Received: by 2002:a25:c593:0:0:0:0:0 with SMTP id v141csp5781884ybe; Tue, 17 Sep 2019 13:26:55 -0700 (PDT) X-Google-Smtp-Source: APXvYqzoHQmTM/nB72jQdOHpwYmRTt5gjSIFCFUKdS4nPpRmBPki2KbpnVRurUZXbTttoPv2YQJY X-Received: by 2002:a50:bb22:: with SMTP id y31mr7020539ede.58.1568752015353; Tue, 17 Sep 2019 13:26:55 -0700 (PDT) ARC-Seal: i=1; a=rsa-sha256; t=1568752015; cv=none; d=google.com; s=arc-20160816; b=VLM9By7o5yKP6ku89cYVU3FGryBNSLRdx3B6Yvf2snYhoWZc/Yodrm4d8AQh25xks2 u8U8TQfx6BZJZB3lZuJJde4mDm5zMnmkKc13/TMl/kTlEPq4B6EgNEoSqx0KCxYKGF/F Zb9HL1v302EH03+MiAYoxf1hPPgNsWNNvIzqn6ZUFnppgkWMzwL1xe+NxeIOOVZcj3pj nFq0Ywdptj+dmfVilzGliy0ngFEmGnke6igYuW9RrMgc31PGIk/HEx/6VerNdYIG4taU koEswc66FhdzMyD/xK7kiJU+nvYdyNZ/uKYo6evPCNv0mYkcSsIwe8Jhn4z1tV0HWJfJ 7LRg== ARC-Message-Signature: i=1; a=rsa-sha256; c=relaxed/relaxed; d=google.com; s=arc-20160816; h=list-id:precedence:sender:cc:to:subject:message-id:date:from :in-reply-to:references:mime-version:dkim-signature; bh=Ok9E1o6OUNVWjjY+77my6npA/03ah1o2Ms5QHIzAZME=; b=jKINgexSLS9M56ZnoANUI6J26MNUjOlvUYPpICV2Zsny+M1ZN1Way4AAOHRfFCb1Be qXQR3OxHmFujP67oJSIcgx9Kc62jowNID5+yjNDpmqYOEe96JmIyzyqJHFkU1eSu6Vkp aetdIIY9GWKR0MpoL2H6U7St6nRN83YSClFlgGBdEbUHYQ4A7HX6i5fpwlKGFfcmzD8i +krPF/7eldEpb7zCciDn6rnqbohbfZzSUDki1FQdMEE9zoT6uuA9vj688OocaAAlRB2j GB4UwUT52YpJbgeD3kNU7md3NMD59S2Pw04buJ7GZGkOxLAJopZECVTNB/bxTC0sRtah W9Qw== ARC-Authentication-Results: i=1; mx.google.com; dkim=pass header.i=@gmail.com header.s=20161025 header.b=tLSaRYhr; spf=pass (google.com: best guess record for domain of linux-wireless-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) smtp.mailfrom=linux-wireless-owner@vger.kernel.org; dmarc=pass (p=NONE sp=QUARANTINE dis=NONE) header.from=gmail.com Return-Path: Received: from vger.kernel.org (vger.kernel.org. [209.132.180.67]) by mx.google.com with ESMTP id h26si1920164edb.141.2019.09.17.13.26.26; Tue, 17 Sep 2019 13:26:55 -0700 (PDT) Received-SPF: pass (google.com: best guess record for domain of linux-wireless-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) client-ip=209.132.180.67; Authentication-Results: mx.google.com; dkim=pass header.i=@gmail.com header.s=20161025 header.b=tLSaRYhr; spf=pass (google.com: best guess record for domain of linux-wireless-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) smtp.mailfrom=linux-wireless-owner@vger.kernel.org; dmarc=pass (p=NONE sp=QUARANTINE dis=NONE) header.from=gmail.com Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1727518AbfIQU0K (ORCPT + 99 others); Tue, 17 Sep 2019 16:26:10 -0400 Received: from mail-io1-f52.google.com ([209.85.166.52]:35240 "EHLO mail-io1-f52.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1726340AbfIQU0J (ORCPT ); Tue, 17 Sep 2019 16:26:09 -0400 Received: by mail-io1-f52.google.com with SMTP id q10so10872328iop.2 for ; Tue, 17 Sep 2019 13:26:08 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20161025; h=mime-version:references:in-reply-to:from:date:message-id:subject:to :cc; bh=Ok9E1o6OUNVWjjY+77my6npA/03ah1o2Ms5QHIzAZME=; b=tLSaRYhroz9hQKbFlUiuJr/YOPbuma8zQHlLwlU5JD7jJbqy8mvj9hYwvcUX+LCo3O q2hqULxBn9ZsCCCIxh0k21+Jn6TbfYt9DC/dBgM6OZmIgniIajoolH4EZrv64qdpjKoI 18Ys97YcWPFWlQ+JzHXLrhowoGLswX6xcSQ6ppHaG+ZMI18lXyDFgP+07vnd9S3K0Q0M 7AymrXw4lSugythwAYLX7EFhkz/xajuOptiy8qDi59fK6m5HUGukBswSIhMkX3jZwR3b cWgGO6Q3c7TRwQ+t+yrCZZZNNwH0zQhFuoadbgO+O6kuozxM0tjtrPsZIH7vG1ce+rdC mByA== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20161025; h=x-gm-message-state:mime-version:references:in-reply-to:from:date :message-id:subject:to:cc; bh=Ok9E1o6OUNVWjjY+77my6npA/03ah1o2Ms5QHIzAZME=; b=Gm9DeLE8/638cr8TzaxROCRfl8dSiLXJMMmNI2MhusDUeeuoSXfaE/1fKc3RXuHDqN JL1637AfmnPpUM1sOtLUkn4c/O5N754LwArsDdw9w3ydp/civQVysfyOPdMHmif3dJBt 9u1WN3ERThJoY8r4hjHWG09cgCAI70U30Mym4U1M0su08Sug/qnRl3L64QflIKcs/yTS YJudCuP29jVoRsid+sS4ceCLL/bk7Y3mVxX2/Wekd2xY/5VzD4wlYoCaY72/3yrQ22uT 5VAJgbxVmz5gvX5pAqZa2xWPKNBskfuu5M46nJdsjEvUiiJLSOjO+xTpIMtH8S26eMdz WtKA== X-Gm-Message-State: APjAAAVRYayAElmUXgKjA/hzeN8wZX+RkTHar2ZcofYg4AoD0f6CT5f3 LEU31LcdahMy7HejqFXKM2QOC4P4QquPf1pC1lk= X-Received: by 2002:a02:b156:: with SMTP id s22mr454044jah.102.1568751967673; Tue, 17 Sep 2019 13:26:07 -0700 (PDT) MIME-Version: 1.0 References: In-Reply-To: From: David Ho Date: Tue, 17 Sep 2019 13:25:56 -0700 Message-ID: Subject: Re: Linux wireless times out at Google Starbucks location To: Steve deRosier Cc: linux-wireless Content-Type: text/plain; charset="UTF-8" Sender: linux-wireless-owner@vger.kernel.org Precedence: bulk List-ID: X-Mailing-List: linux-wireless@vger.kernel.org On Tue, Sep 17, 2019 at 12:07 PM Steve deRosier 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. 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- SERR- author: Realtek WlanFAE author: lizhaoming description: PCI basic driver for rtlwifi license: GPL author: Larry Finger author: Realtek WlanFAE author: lizhaoming firmware: rtlwifi/rtl8822befw.bin description: Realtek 8822BE 802.11n PCI wireless license: GPL author: Larry Finger author: Realtek WlanFAE description: Realtek 802.11n PCI wireless core license: GPL author: Larry Finger author: Realtek WlanFAE description: Realtek 802.11n PCI wireless core license: GPL author: Larry Finger author: Realtek WlanFAE 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]: [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]: [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]: [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]: [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]: [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]: [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]: [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]: [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]: [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]: [1568736955.7536] device (wlo1): supplicant interface state: authenticating -> disconnected Sep 17 09:15:57 mumble15 NetworkManager[893]: [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]: [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]: [1568736961.2927] device (wlo1): supplicant interface state: authenticating -> disconnected Sep 17 09:16:03 mumble15 NetworkManager[893]: [1568736963.8164] device (wlo1): Activation: (wifi) association took too long, failing activation Sep 17 09:16:03 mumble15 NetworkManager[893]: [1568736963.8165] device (wlo1): state change: config -> failed (reason 'supplicant-timeout', sys-iface-state: 'managed') Sep 17 09:16:03 mumble15 NetworkManager[893]: [1568736963.8172] manager: NetworkManager state is now DISCONNECTED Sep 17 09:16:03 mumble15 NetworkManager[893]: [1568736963.8186] device (wlo1): Activation: failed for connection 'Google Starbucks' Sep 17 09:16:03 mumble15 NetworkManager[893]: [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]: [1568736968.2980] device (wlo1): supplicant interface state: disconnected -> inactive