Re: Linux wireless times out at Google Starbucks location

[David Ho <davidkwho@gmail.com>]

Hi Dan, Steve,

The issue was fixed by booting the latest 5.0.x upstream kernel !!!  I
guess this has something to do with 5.0.0 and seems to have been fixed
since then.   It appears I put too much faith in an LTS kernel...

$ uname -a
Linux mumble15 5.0.21-050021-generic #201906040731 SMP Tue Jun 4
07:33:07 UTC 2019 x86_64 x86_64 x86_64 GNU/Linux

On Tue, Oct 8, 2019 at 5:33 PM David Ho <davidkwho@gmail.com> wrote:
>
> Hi Dan, Steve,
>
> The issue was fixed by booting the latest 5.0.x upstream kernel !!!  I guess this has something to do with 5.0.0 and seems to have been fixed since then.   It appears I put too much faith in an LTS kernel...
>
> $ uname -a
> Linux mumble15 5.0.21-050021-generic #201906040731 SMP Tue Jun 4 07:33:07 UTC 2019 x86_64 x86_64 x86_64 GNU/Linux
>
> On Wed, Sep 25, 2019 at 3:01 PM David Ho <davidkwho@gmail.com> wrote:
>>
>> Hi Steve, Dan,
>>
>> I have scouted the neighborhood (San Diego, CA) and visited 6
>> Starbucks.  I found another one with the same issue, so 2/6.  This
>> appears to be a systemic issue (Not one-off).
>>
>> I'm wondering if there is anything that you believe I can try at this
>> point.  There is nothing unusual about these stores.  Everyone is
>> happily connected on their Macs, and Windows notebooks.
>>
>> Can you offer any advice or point me to an expert who can help?
>>
>> Regards,
>> David
>>
>>
>> On Tue, Sep 17, 2019 at 2:01 PM Dan Williams <dcbw@redhat.com> wrote:
>> >
>> > On Tue, 2019-09-17 at 13:25 -0700, David Ho wrote:
>> > > On Tue, Sep 17, 2019 at 12:07 PM Steve deRosier <derosier@gmail.com>
>> > > wrote:
>> > > > I will tell you I did go look and you don't have sufficient and
>> > > > useful
>> > > > information for us to help you. We need to know the wifi chipset
>> > > > you're using, the drivers involved, what network subsystems you're
>> > > > using, the methodology of your connection, and the kernel logs
>> > > > themselves would all be helpful.
>> > > >
>> > >
>> > > Hi Steve, pls let me know if you need anything else, David.
>> >
>> > If you're able to get the wpa_supplicant logs, that would be useful as
>> > well.
>> >
>> > sudo dbus-send --system --print-reply --dest=fi.w1.wpa_supplicant1
>> > /fi/w1/wpa_supplicant1 org.freedesktop.DBus.Properties.Set
>> > string:fi.w1.wpa_supplicant1 string:DebugTimestamp variant:boolean:true
>> >
>> > sudo dbus-send --system --print-reply --dest=fi.w1.wpa_supplicant1
>> > /fi/w1/wpa_supplicant1 org.freedesktop.DBus.Properties.Set
>> > string:fi.w1.wpa_supplicant1 string:DebugLevel variant:string:"msgdump"
>> >
>> > will start spewing out tons of information to wherever the supplicant
>> > sends log information on Ubuntu (systemd, syslog, etc).
>> >
>> > Dan
>> >
>> > > High level: Google Starbucks Wifi connection, Unencrypted AP (see AP
>> > > info below)
>> > > Connection method: NetworkManager, wpa_applicant (see exerpt from
>> > > /var/log/syslog below)
>> > >                    (see also iw event -f below)
>> > > Linux kernel: 5.0.0-27
>> > > Network subsystem: mac80211, cfg80211 (not sure)
>> > > Wifi chipset: RTL8822BE 802.11a/b/g/n/ac (see below)
>> > > Kernel driver in use: rtw_pci (see below)
>> > > Kernel modules: rtwpci, r8822be (see below)
>> > > Kernel log: see /var/log/kern.log exerpt below
>> > >
>> > > Problem detail
>> > > ------------------
>> > >
>> > > I had trouble connecting my Ubuntu 18.04.3 LTS laptop to one specific
>> > > Starbucks location in my neighborhood, (Note that it works for 2/3
>> > > Starbucks and another public wifi location so this is an outlier;
>> > > However, I have been coming to this Starbucks at least 30 times in
>> > > the
>> > > past and it worked 100% for my Windows laptop and Andriod phone, and
>> > > I
>> > > have never seen customers with iPhones/MacBooks complaining, thus it
>> > > is being handled routinely by other major OS's)
>> > >
>> > > I have been tracking down this problem for three days and I believe I
>> > > have a good handle on what the problem may be.
>> > >
>> > > The event log below shows that after successfully authenticated,
>> > > association timed-out after 3 tries (seen in the kernel log in
>> > > /var/log/syslog). The next attempt to associate with the AP was
>> > > denied
>> > > because the WTA (my laptop) has been associated according to the AP.
>> > > Thus I believe the client timed out before the association response
>> > > from the AP reaches the WTA.
>> > >
>> > > I looked over the Linux wireless user's doc, but I didn't find a way
>> > > to tweak the configuration to test my hypothesis. Perhaps the
>> > > wireless
>> > > subsystem folks can shed some lights on this problem to help with
>> > > this?
>> > >
>> > > davidkwho@mumble15:~$ iw event -f
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, ""
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, "Google Starbucks" ""
>> > > wlo1: new station 24:de:c6:cb:2a:d8
>> > > wlo1 (phy #0): auth 24:de:c6:cb:2a:d8 -> 48:5f:99:bc:ab:b9 status: 0:
>> > > Successful [frame: b0 00 3c 00 48 5f 99 bc ab b9 24 de c6 cb 2a d8 24
>> > > de c6 cb 2a d8 10 c5 00 00 02 00 00 00]
>> > > wlo1: del station 24:de:c6:cb:2a:d8
>> > > wlo1 (phy #0): assoc: timed out
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, "Google Starbucks" ""
>> > > wlo1: new station 24:de:c6:cb:2a:d0
>> > > wlo1: del station 24:de:c6:cb:2a:d0
>> > > wlo1 (phy #0): auth 24:de:c6:cb:2a:d0 -> 48:5f:99:bc:ab:b9 status:
>> > > 17:
>> > > Association denied because AP is unable to handle additional
>> > > associated STA [frame: b0 00 3c 00 48 5f 99 bc ab b9 24 de c6 cb 2a
>> > > d0
>> > > 24 de c6 cb 2a d0 20 0b 00 00 02 00 11 00]
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, ""
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, ""
>> > > wlo1 (phy #0): scan started
>> > > wlo1 (phy #0): scan finished: 2412 2417 2422 2427 2432 2437 2442 2447
>> > > 2452 2457 2462 2467 2472 2484 5180 5200 5220 5240 5260 5280 5300 5320
>> > > 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785
>> > > 5805 5825, ""
>> > >
>> > > Wireless AP info
>> > > $ iw dev wlo1 scan
>> > > BSS 24:de:c6:cb:2a:d8(on wlo1)
>> > > TSF: 2927364433352 usec (33d, 21:09:24)
>> > > freq: 5765
>> > > beacon interval: 100 TUs
>> > > capability: ESS SpectrumMgmt ShortSlotTime (0x0501)
>> > > signal: -41.00 dBm
>> > > last seen: 320 ms ago
>> > > Information elements from Probe Response frame:
>> > > SSID: Google Starbucks
>> > > Supported rates: 6.0* 9.0 12.0* 18.0 24.0* 36.0 48.0 54.0
>> > > DS Parameter set: channel 153
>> > > Country: US Environment: Indoor/Outdoor
>> > > Channels [36 - 64] @ 36 dBm
>> > > Channels [100 - 140] @ 30 dBm
>> > > Channels [149 - 165] @ 36 dBm
>> > > Power constraint: 0 dB
>> > > TPC report: TX power: 23 dBm
>> > > BSS Load:
>> > > * station count: 7
>> > > * channel utilisation: 2/255
>> > > * available admission capacity: 30937 [*32us]
>> > > HT capabilities:
>> > > Capabilities: 0x9ce
>> > > HT20/HT40
>> > > SM Power Save disabled
>> > > RX HT40 SGI
>> > > TX STBC
>> > > RX STBC 1-stream
>> > > Max AMSDU length: 7935 bytes
>> > > No DSSS/CCK HT40
>> > > Maximum RX AMPDU length 65535 bytes (exponent: 0x003)
>> > > Minimum RX AMPDU time spacing: 16 usec (0x07)
>> > > HT RX MCS rate indexes supported: 0-15
>> > > HT TX MCS rate indexes are undefined
>> > > HT operation:
>> > > * primary channel: 153
>> > > * secondary channel offset: below
>> > > * STA channel width: any
>> > > * RIFS: 0
>> > > * HT protection: 20 MHz
>> > > * non-GF present: 0
>> > > * OBSS non-GF present: 0
>> > > * dual beacon: 0
>> > > * dual CTS protection: 0
>> > > * STBC beacon: 0
>> > > * L-SIG TXOP Prot: 0
>> > > * PCO active: 0
>> > > * PCO phase: 0
>> > > Extended capabilities:
>> > > * BSS Transition
>> > > WMM: * Parameter version 1
>> > > * u-APSD
>> > > * BE: CW 15-1023, AIFSN 3
>> > > * BK: CW 15-1023, AIFSN 7
>> > > * VI: CW 7-15, AIFSN 2, TXOP 3008 usec
>> > > * VO: CW 3-7, AIFSN 2, TXOP 1504 usec
>> > >
>> > > davidkwho@mumble15:~$ uname -a
>> > > Linux mumble15 5.0.0-27-generic #28~18.04.1-Ubuntu SMP Thu Aug 22
>> > > 03:00:32 UTC 2019 x86_64 x86_64 x86_64 GNU/Linux
>> > >
>> > > davidkwho@mumble15:~$ sudo lspci -nn -s 02:00.0
>> > > 02:00.0 Network controller [0280]: Realtek Semiconductor Co., Ltd.
>> > > RTL8822BE 802.11a/b/g/n/ac WiFi adapter [10ec:b822]
>> > >
>> > > davidkwho@mumble15:~$ sudo lspci -vv -s 02:00.0
>> > > 02:00.0 Network controller: Realtek Semiconductor Co., Ltd. RTL8822BE
>> > > 802.11a/b/g/n/ac WiFi adapter
>> > > Subsystem: Hewlett-Packard Company Device 831b
>> > > Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr-
>> > > Stepping- SERR- FastB2B- DisINTx-
>> > > Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort-
>> > > <TAbort- <MAbort- >SERR- <PERR- INTx-
>> > > Latency: 0, Cache Line Size: 64 bytes
>> > > Interrupt: pin A routed to IRQ 17
>> > > Region 0: I/O ports at 3000 [size=256]
>> > > Region 2: Memory at b1000000 (64-bit, non-prefetchable) [size=64K]
>> > > Capabilities: [40] Power Management version 3
>> > > Flags: PMEClk- DSI- D1+ D2+ AuxCurrent=375mA
>> > > PME(D0+,D1+,D2+,D3hot+,D3cold+)
>> > > Status: D0 NoSoftRst+ PME-Enable- DSel=0 DScale=0 PME-
>> > > Capabilities: [50] MSI: Enable- Count=1/1 Maskable- 64bit+
>> > > Address: 0000000000000000  Data: 0000
>> > > Capabilities: [70] Express (v2) Endpoint, MSI 00
>> > > DevCap: MaxPayload 128 bytes, PhantFunc 0, Latency L0s <4us, L1 <64us
>> > > ExtTag- AttnBtn- AttnInd- PwrInd- RBE+ FLReset- SlotPowerLimit
>> > > 10.000W
>> > > DevCtl: Report errors: Correctable- Non-Fatal- Fatal- Unsupported-
>> > > RlxdOrd+ ExtTag- PhantFunc- AuxPwr- NoSnoop-
>> > > MaxPayload 128 bytes, MaxReadReq 512 bytes
>> > > DevSta: CorrErr- UncorrErr- FatalErr- UnsuppReq- AuxPwr+ TransPend-
>> > > LnkCap: Port #0, Speed 2.5GT/s, Width x1, ASPM L0s L1, Exit Latency
>> > > L0s <2us, L1 <64us
>> > > ClockPM+ Surprise- LLActRep- BwNot- ASPMOptComp-
>> > > LnkCtl: ASPM L1 Enabled; RCB 64 bytes Disabled- CommClk+
>> > > ExtSynch- ClockPM+ AutWidDis- BWInt- AutBWInt-
>> > > LnkSta: Speed 2.5GT/s, Width x1, TrErr- Train- SlotClk+ DLActive-
>> > > BWMgmt- ABWMgmt-
>> > > DevCap2: Completion Timeout: Not Supported, TimeoutDis+, LTR+, OBFF
>> > > Via message/WAKE#
>> > > DevCtl2: Completion Timeout: 50us to 50ms, TimeoutDis-, LTR+, OBFF
>> > > Disabled
>> > > LnkCtl2: Target Link Speed: 5GT/s, EnterCompliance- SpeedDis-
>> > > Transmit Margin: Normal Operating Range, EnterModifiedCompliance-
>> > > ComplianceSOS-
>> > > Compliance De-emphasis: -6dB
>> > > LnkSta2: Current De-emphasis Level: -3.5dB, EqualizationComplete-,
>> > > EqualizationPhase1-
>> > > EqualizationPhase2-, EqualizationPhase3-, LinkEqualizationRequest-
>> > > Capabilities: [100 v2] Advanced Error Reporting
>> > > UESta: DLP- SDES- TLP- FCP- CmpltTO- CmpltAbrt- UnxCmplt- RxOF-
>> > > MalfTLP- ECRC- UnsupReq- ACSViol-
>> > > UEMsk: DLP- SDES- TLP- FCP- CmpltTO- CmpltAbrt- UnxCmplt- RxOF-
>> > > MalfTLP- ECRC- UnsupReq- ACSViol-
>> > > UESvrt: DLP+ SDES+ TLP- FCP+ CmpltTO- CmpltAbrt- UnxCmplt- RxOF+
>> > > MalfTLP+ ECRC- UnsupReq- ACSViol-
>> > > CESta: RxErr- BadTLP- BadDLLP- Rollover- Timeout- NonFatalErr-
>> > > CEMsk: RxErr- BadTLP- BadDLLP- Rollover- Timeout- NonFatalErr+
>> > > AERCap: First Error Pointer: 00, GenCap+ CGenEn- ChkCap+ ChkEn-
>> > > Capabilities: [148 v1] Device Serial Number 00-e0-4c-ff-fe-b8-22-01
>> > > Capabilities: [158 v1] Latency Tolerance Reporting
>> > > Max snoop latency: 3145728ns
>> > > Max no snoop latency: 3145728ns
>> > > Capabilities: [160 v1] L1 PM Substates
>> > > L1SubCap: PCI-PM_L1.2- PCI-PM_L1.1- ASPM_L1.2- ASPM_L1.1-
>> > > L1_PM_Substates-
>> > > L1SubCtl1: PCI-PM_L1.2- PCI-PM_L1.1- ASPM_L1.2- ASPM_L1.1-
>> > >
>> > > L1SubCtl2:
>> > > Kernel driver in use: rtw_pci
>> > > Kernel modules: rtwpci, r8822be
>> > >
>> > > davidkwho@mumble15:~$ modinfo rtwpci
>> > > filename:
>> > > /lib/modules/5.0.0-27-
>> > > generic/kernel/drivers/net/wireless/realtek/rtw88/rtwpci.ko
>> > > license:        Dual BSD/GPL
>> > > description:    Realtek 802.11ac wireless PCI driver
>> > > author:         Realtek Corporation
>> > > srcversion:     4B7E47842DAA873E20D1238
>> > > alias:          pci:v000010ECd0000C822sv*sd*bc*sc*i*
>> > > alias:          pci:v000010ECd0000B822sv*sd*bc*sc*i*
>> > > depends:        mac80211,rtw88
>> > > retpoline:      Y
>> > > intree:         Y
>> > > name:           rtwpci
>> > > vermagic:       5.0.0-27-generic SMP mod_unload
>> > > signat:         PKCS#7
>> > > signer:
>> > > sig_key:
>> > > sig_hashalgo:   md4
>> > >
>> > >
>> > > davidkwho@mumble15:~$ modinfo r8822be
>> > > filename:
>> > > /lib/modules/5.0.0-27-
>> > > generic/kernel/drivers/staging/rtlwifi/r8822be.ko
>> > > description:    Realtek 802.11n PCI wireless core
>> > > license:        GPL
>> > > author:         Larry Finger <Larry.FInger@lwfinger.net>
>> > > author:         Realtek WlanFAE <wlanfae@realtek.com>
>> > > author:         lizhaoming <chaoming_li@realsil.com.cn>
>> > > description:    PCI basic driver for rtlwifi
>> > > license:        GPL
>> > > author:         Larry Finger <Larry.FInger@lwfinger.net>
>> > > author:         Realtek WlanFAE <wlanfae@realtek.com>
>> > > author:         lizhaoming <chaoming_li@realsil.com.cn>
>> > > firmware:       rtlwifi/rtl8822befw.bin
>> > > description:    Realtek 8822BE 802.11n PCI wireless
>> > > license:        GPL
>> > > author:         Larry Finger <Larry.Finger@lwfinger.net>
>> > > author:         Realtek WlanFAE <wlanfae@realtek.com>
>> > > description:    Realtek 802.11n PCI wireless core
>> > > license:        GPL
>> > > author:         Larry Finger <Larry.FInger@lwfinger.net>
>> > > author:         Realtek WlanFAE <wlanfae@realtek.com>
>> > > description:    Realtek 802.11n PCI wireless core
>> > > license:        GPL
>> > > author:         Larry Finger <Larry.FInger@lwfinger.net>
>> > > author:         Realtek WlanFAE <wlanfae@realtek.com>
>> > > srcversion:     486B19E09315807AE50AE2D
>> > > alias:          pci:v000010ECd0000B822sv*sd*bc*sc*i*
>> > > depends:        mac80211,cfg80211
>> > > staging:        Y
>> > > retpoline:      Y
>> > > intree:         Y
>> > > name:           r8822be
>> > > vermagic:       5.0.0-27-generic SMP mod_unload
>> > > signat:         PKCS#7
>> > > signer:
>> > > sig_key:
>> > > sig_hashalgo:   md4
>> > > parm:           debug_level:int
>> > > parm:           swenc:Set to 1 for software crypto (default 0)
>> > >  (bool)
>> > > parm:           ips:Set to 0 to not use link power save (default 1)
>> > >  (bool)
>> > > parm:           swlps:Set to 1 to use SW control power save (default
>> > > 0)
>> > >  (bool)
>> > > parm:           fwlps:Set to 1 to use FW control power save (default
>> > > 1)
>> > >  (bool)
>> > > parm:           msi:Set to 1 to use MSI interrupts mode (default 1)
>> > >  (bool)
>> > > parm:           dma64:Set to 1 to use DMA 64 (default 0)
>> > >  (bool)
>> > > parm:           aspm:Set to 1 to enable ASPM (default 1)
>> > >  (int)
>> > > parm:           debug:Set debug level (0-5) (default 0)
>> > > parm:           debug_mask:Set debug mask (default 0) (ullong)
>> > > parm:           disable_watchdog:Set to 1 to disable the watchdog
>> > > (default 0)
>> > >  (bool)
>> > >
>> > > excerpt from /var/log/kern.log
>> > >
>> > > Sep 17 10:04:10 mumble15 kernel: [ 3027.669072] rtw_pci 0000:02:00.0:
>> > > stop vif 48:5f:99:bc:ab:b9 on port 0
>> > > Sep 17 10:04:11 mumble15 kernel: [ 3028.363198] rtw_pci 0000:02:00.0:
>> > > start vif 48:5f:99:bc:ab:b9 on port 0
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3082.392651] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3082.891812] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3082.893326] wlo1: authenticated
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3082.895705] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3082.999946] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 10:05:05 mumble15 kernel: [ 3083.108066] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 10:05:06 mumble15 kernel: [ 3083.212065] wlo1: association
>> > > with
>> > > 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 10:05:10 mumble15 kernel: [ 3087.321806] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 10:05:10 mumble15 kernel: [ 3087.820063] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:05:10 mumble15 kernel: [ 3087.923790] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 10:05:10 mumble15 kernel: [ 3088.027966] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 10:05:10 mumble15 kernel: [ 3088.131991] wlo1: authentication
>> > > with 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 10:05:15 mumble15 kernel: [ 3092.637001] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d0
>> > > Sep 17 10:05:15 mumble15 kernel: [ 3093.135834] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d0 (try 1/3)
>> > > Sep 17 10:05:15 mumble15 kernel: [ 3093.141686] wlo1:
>> > > 24:de:c6:cb:2a:d0 denied authentication (status 17)
>> > > Sep 17 10:05:20 mumble15 kernel: [ 3097.661509] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 10:05:20 mumble15 kernel: [ 3098.159806] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.263955] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.273381] wlo1: authenticated
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.279772] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.384004] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.496082] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 10:05:21 mumble15 kernel: [ 3098.604080] wlo1: association
>> > > with
>> > > 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 10:05:23 mumble15 kernel: [ 3100.190473] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d0
>> > > Sep 17 10:05:23 mumble15 kernel: [ 3100.691844] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d0 (try 1/3)
>> > > Sep 17 10:05:23 mumble15 kernel: [ 3100.694973] wlo1:
>> > > 24:de:c6:cb:2a:d0 denied authentication (status 17)
>> > > Sep 17 10:14:24 mumble15 canonical-livepatch[985]: Client.Check
>> > > Sep 17 10:14:24 mumble15 canonical-livepatch[985]: error in livepatch
>> > > check state: check-failed
>> > > Sep 17 10:14:24 mumble15 canonical-livepatch[985]: Checking with
>> > > livepatch service.
>> > > Sep 17 10:14:24 mumble15 canonical-livepatch[985]: No payload
>> > > available.
>> > > Sep 17 10:14:24 mumble15 canonical-livepatch[985]: during refresh:
>> > > cannot check: cannot send status to server: cannot send request: Put
>> > > https://livepatch.canonical.com/api/machine/d34ed7a7967e44fab3d249a4160a5e66:
>> > > dial tcp: lookup livepatch.canonical.com: no such host
>> > > Sep 17 10:14:54 mumble15 canonical-livepatch[985]: Client.Check
>> > > Sep 17 10:14:54 mumble15 canonical-livepatch[985]: error in livepatch
>> > > check state: check-failed
>> > > Sep 17 10:14:54 mumble15 canonical-livepatch[985]: Checking with
>> > > livepatch service.
>> > > Sep 17 10:14:54 mumble15 canonical-livepatch[985]: No payload
>> > > available.
>> > > Sep 17 10:14:54 mumble15 canonical-livepatch[985]: during refresh:
>> > > cannot check: cannot send status to server: cannot send request: Put
>> > > https://livepatch.canonical.com/api/machine/d34ed7a7967e44fab3d249a4160a5e66:
>> > > dial tcp: lookup livepatch.canonical.com: no such host
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.196761] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.695694] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.696900] wlo1: authenticated
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.699665] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.803715] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4452.919898] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 10:27:55 mumble15 kernel: [ 4453.023876] wlo1: association
>> > > with
>> > > 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 10:28:09 mumble15 kernel: [ 4467.040008] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d0
>> > > Sep 17 10:28:10 mumble15 kernel: [ 4467.539834] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d0 (try 1/3)
>> > > Sep 17 10:28:10 mumble15 kernel: [ 4467.540985] wlo1:
>> > > 24:de:c6:cb:2a:d0 denied authentication (status 17)
>> > >
>> > > excerpt from /var/log/syslog
>> > >
>> > > Sep 17 09:15:41 mumble15 NetworkManager[893]: <info>
>> > > [1568736941.1707] device (wlo1): supplicant interface state: ready ->
>> > > scanning
>> > > Sep 17 09:15:44 mumble15 wpa_supplicant[892]: wlo1: SME: Trying to
>> > > authenticate with 24:de:c6:cb:2a:d8 (SSID='Google Starbucks'
>> > > freq=5765
>> > > MHz)
>> > > Sep 17 09:15:44 mumble15 kernel: [  121.844764] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.343740] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 09:15:45 mumble15 NetworkManager[893]: <info>
>> > > [1568736945.1620] device (wlo1): supplicant interface state: scanning
>> > > -> authenticating
>> > > Sep 17 09:15:45 mumble15 wpa_supplicant[892]: wlo1: Trying to
>> > > associate with 24:de:c6:cb:2a:d8 (SSID='Google Starbucks' freq=5765
>> > > MHz)
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.344991] wlo1: authenticated
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.348006] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 09:15:45 mumble15 NetworkManager[893]: <info>
>> > > [1568736945.1793] device (wlo1): supplicant interface state:
>> > > authenticating -> associating
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.452300] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.556317] wlo1: associate with
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 09:15:45 mumble15 kernel: [  122.664332] wlo1: association
>> > > with
>> > > 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 09:15:45 mumble15 NetworkManager[893]: <info>
>> > > [1568736945.5173] device (wlo1): supplicant interface state:
>> > > associating -> disconnected
>> > > Sep 17 09:15:45 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Activating via systemd: service
>> > > name='org.gnome.zeitgeist.Engine' unit='zeitgeist.service' requested
>> > > by ':1.72' (uid=1000 pid=2152 comm="zeitgeist-datahub "
>> > > label="unconfined")
>> > > Sep 17 09:15:45 mumble15 systemd[1645]: Starting Zeitgeist activity
>> > > log service...
>> > > Sep 17 09:15:45 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Activating via systemd: service
>> > > name='org.gnome.zeitgeist.SimpleIndexer' unit='zeitgeist-fts.service'
>> > > requested by ':1.73' (uid=1000 pid=2161
>> > > comm="/usr/bin/zeitgeist-daemon " label="unconfined")
>> > > Sep 17 09:15:45 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Successfully activated service 'org.gnome.zeitgeist.Engine'
>> > > Sep 17 09:15:45 mumble15 systemd[1645]: Started Zeitgeist activity
>> > > log service.
>> > > Sep 17 09:15:45 mumble15 systemd[1645]: Starting Zeitgeist full-text
>> > > search indexer...
>> > > Sep 17 09:15:45 mumble15 zeitgeist-daemon[2161]:
>> > > #033[31m[16:15:45.840283 WARNING]#033[0m zeitgeist-daemon.vala:127:
>> > > Unable to parse version info!
>> > > Sep 17 09:15:45 mumble15 zeitgeist-daemon[2161]:
>> > > #033[31m[16:15:45.840478 WARNING]#033[0m zeitgeist-daemon.vala:127:
>> > > Unable to parse version info!
>> > > Sep 17 09:15:45 mumble15 zeitgeist-daemon[2161]:
>> > > #033[31m[16:15:45.851906 WARNING]#033[0m zeitgeist-daemon.vala:127:
>> > > Unable to parse version info!
>> > > Sep 17 09:15:45 mumble15 zeitgeist-datah[2168]:
>> > > zeitgeist-datahub.vala:227: Unable to get name
>> > > "org.gnome.zeitgeist.datahub" on the bus!
>> > > Sep 17 09:15:45 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Successfully activated service
>> > > 'org.gnome.zeitgeist.SimpleIndexer'
>> > > Sep 17 09:15:45 mumble15 systemd[1645]: Started Zeitgeist full-text
>> > > search indexer.
>> > > Sep 17 09:15:46 mumble15 NetworkManager[893]: <info>
>> > > [1568736946.1109] device (wlo1): supplicant interface state:
>> > > disconnected -> scanning
>> > > Sep 17 09:15:49 mumble15 wpa_supplicant[892]: nl80211:
>> > > send_and_recv->nl_recvmsgs failed: -33
>> > > Sep 17 09:15:49 mumble15 wpa_supplicant[892]: wlo1: SME: Trying to
>> > > authenticate with 24:de:c6:cb:2a:d8 (SSID='Google Starbucks'
>> > > freq=5765
>> > > MHz)
>> > > Sep 17 09:15:49 mumble15 kernel: [  126.781671] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 09:15:50 mumble15 NetworkManager[893]: <info>
>> > > [1568736950.0994] device (wlo1): supplicant interface state: scanning
>> > > -> authenticating
>> > > Sep 17 09:15:50 mumble15 kernel: [  127.280174] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 09:15:50 mumble15 kernel: [  127.384202] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 09:15:50 mumble15 kernel: [  127.488275] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 09:15:50 mumble15 kernel: [  127.592303] wlo1: authentication
>> > > with 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 09:15:50 mumble15 NetworkManager[893]: <info>
>> > > [1568736950.4335] device (wlo1): supplicant interface state:
>> > > authenticating -> disconnected
>> > > Sep 17 09:15:50 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Activating via systemd: service name='org.gnome.Terminal'
>> > > unit='gnome-terminal-server.service' requested by ':1.77' (uid=1000
>> > > pid=2199 comm="/usr/bin/gnome-terminal.real " label="unconfined")
>> > > Sep 17 09:15:50 mumble15 systemd[1645]: Starting GNOME Terminal
>> > > Server...
>> > > Sep 17 09:15:50 mumble15 dbus-daemon[1671]: [session uid=1000
>> > > pid=1671] Successfully activated service 'org.gnome.Terminal'
>> > > Sep 17 09:15:50 mumble15 systemd[1645]: Started GNOME Terminal
>> > > Server.
>> > > Sep 17 09:15:51 mumble15 NetworkManager[893]: <info>
>> > > [1568736951.4267] device (wlo1): supplicant interface state:
>> > > disconnected -> scanning
>> > > Sep 17 09:15:54 mumble15 wpa_supplicant[892]: wlo1: SME: Trying to
>> > > authenticate with 24:de:c6:cb:2a:d8 (SSID='Google Starbucks'
>> > > freq=5765
>> > > MHz)
>> > > Sep 17 09:15:54 mumble15 kernel: [  132.102375] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 09:15:55 mumble15 kernel: [  132.599927] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 09:15:55 mumble15 NetworkManager[893]: <info>
>> > > [1568736955.4232] device (wlo1): supplicant interface state: scanning
>> > > -> authenticating
>> > > Sep 17 09:15:55 mumble15 kernel: [  132.704246] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 09:15:55 mumble15 kernel: [  132.808252] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 09:15:55 mumble15 kernel: [  132.912292] wlo1: authentication
>> > > with 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 09:15:55 mumble15 NetworkManager[893]: <info>
>> > > [1568736955.7536] device (wlo1): supplicant interface state:
>> > > authenticating -> disconnected
>> > > Sep 17 09:15:57 mumble15 NetworkManager[893]: <info>
>> > > [1568736957.2508] device (wlo1): supplicant interface state:
>> > > disconnected -> scanning
>> > > Sep 17 09:16:00 mumble15 wpa_supplicant[892]: wlo1: SME: Trying to
>> > > authenticate with 24:de:c6:cb:2a:d8 (SSID='Google Starbucks'
>> > > freq=5765
>> > > MHz)
>> > > Sep 17 09:16:00 mumble15 kernel: [  137.921958] wlo1: authenticate
>> > > with 24:de:c6:cb:2a:d8
>> > > Sep 17 09:16:01 mumble15 NetworkManager[893]: <info>
>> > > [1568736961.2395] device (wlo1): supplicant interface state: scanning
>> > > -> authenticating
>> > > Sep 17 09:16:01 mumble15 kernel: [  138.420186] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 1/3)
>> > > Sep 17 09:16:01 mumble15 kernel: [  138.426618] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 2/3)
>> > > Sep 17 09:16:01 mumble15 kernel: [  138.433025] wlo1: send auth to
>> > > 24:de:c6:cb:2a:d8 (try 3/3)
>> > > Sep 17 09:16:01 mumble15 kernel: [  138.439447] wlo1: authentication
>> > > with 24:de:c6:cb:2a:d8 timed out
>> > > Sep 17 09:16:01 mumble15 wpa_supplicant[892]: wlo1:
>> > > CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Google Starbucks"
>> > > auth_failures=1 duration=10 reason=CONN_FAILED
>> > > Sep 17 09:16:01 mumble15 NetworkManager[893]: <info>
>> > > [1568736961.2927] device (wlo1): supplicant interface state:
>> > > authenticating -> disconnected
>> > > Sep 17 09:16:03 mumble15 NetworkManager[893]: <warn>
>> > > [1568736963.8164] device (wlo1): Activation: (wifi) association took
>> > > too long, failing activation
>> > > Sep 17 09:16:03 mumble15 NetworkManager[893]: <info>
>> > > [1568736963.8165] device (wlo1): state change: config -> failed
>> > > (reason 'supplicant-timeout', sys-iface-state: 'managed')
>> > > Sep 17 09:16:03 mumble15 NetworkManager[893]: <info>
>> > > [1568736963.8172] manager: NetworkManager state is now DISCONNECTED
>> > > Sep 17 09:16:03 mumble15 NetworkManager[893]: <warn>
>> > > [1568736963.8186] device (wlo1): Activation: failed for connection
>> > > 'Google Starbucks'
>> > > Sep 17 09:16:03 mumble15 NetworkManager[893]: <info>
>> > > [1568736963.8202] device (wlo1): state change: failed -> disconnected
>> > > (reason 'none', sys-iface-state: 'managed')
>> > > Sep 17 09:16:03 mumble15 dbus-daemon[1124]: [session uid=121
>> > > pid=1124]
>> > > Activating service name='ca.desrt.dconf' requested by ':1.13'
>> > > (uid=121
>> > > pid=1139 comm="/usr/bin/gnome-shell " label="unconfined")
>> > > Sep 17 09:16:03 mumble15 dbus-daemon[1124]: [session uid=121
>> > > pid=1124]
>> > > Successfully activated service 'ca.desrt.dconf'
>> > > Sep 17 09:16:03 mumble15 gnome-shell[1824]: An active wireless
>> > > connection, in infrastructure mode, involves no access point?
>> > > Sep 17 09:16:03 mumble15 gnome-shell[1139]: An active wireless
>> > > connection, in infrastructure mode, involves no access point?
>> > > Sep 17 09:16:08 mumble15 NetworkManager[893]: <info>
>> > > [1568736968.2980] device (wlo1): supplicant interface state:
>> > > disconnected -> inactive
>> >