Bug 913602 - Wireless fails to reconnect after laptop sleep
Summary: Wireless fails to reconnect after laptop sleep
Keywords:
Status: CLOSED NOTABUG
Alias: None
Product: Fedora
Classification: Fedora
Component: kernel
Version: 17
Hardware: x86_64
OS: Linux
unspecified
low
Target Milestone: ---
Assignee: Stanislaw Gruszka
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2013-02-21 15:22 UTC by M Miller
Modified: 2013-03-21 16:35 UTC (History)
10 users (show)

Fixed In Version:
Clone Of:
Environment:
Last Closed: 2013-03-21 14:36:35 UTC
Type: Bug
Embargoed:


Attachments (Terms of Use)
DMESG output with modules still loaded (75.34 KB, text/plain)
2013-03-13 01:32 UTC, M Miller
no flags Details
DMESG output with modules removed (77.86 KB, text/plain)
2013-03-13 01:32 UTC, M Miller
no flags Details
Scan Output from iw command (19.58 KB, text/plain)
2013-03-19 21:28 UTC, M Miller
no flags Details

Description M Miller 2013-02-21 15:22:28 UTC
Description of problem:
Fedora 17 HP laptop - after suspending the wireless will not reconnect. It will show "Connecting" in network manager and then prompt for a password. This cycle will repeat but will not connect.

Version-Release number of selected component (if applicable):
$ uname -a
Linux grover.millerz.info 3.7.6-102.fc17.x86_64 #1 SMP Mon Feb 4 17:40:25 UTC 2013 x86_64 x86_64 x86_64 GNU/Linux
$ cat /etc/fedora-release 
Fedora release 17 (Beefy Miracle)


How reproducible:


Steps to Reproduce:
1. Verify wireless connection
2. Remove wireless module (have also tried without removal)
3. Sleep laptop and resume
4. Re-load modules
5. Attempt to reconnect
  
Actual results:
Prompted for wireless network password repeatedly.  Unable to reconnect without reboot.

Expected results:
Automatically reconnected upon resume

Additional info:
I've been able to reproduce with the following kernels:
kernel-3.7.6-102.fc17.x86_64
kernel-3.6.11-1.fc17.x86_64
kernel-3.6.10-2.fc17.x86_64
kernel-3.5.4-2.fc17.x86_64
kernel-3.5.3-1.fc17.x86_64

The only system logs I'm seeing at the time of the issues:
Oct  3 08:24:06 grover kernel: [ 4872.475887] iwlwifi 0000:07:00.0: >fail to flush all tx fifo queues
08:24:06 grover NetworkManager[741]: <info> (wlan0): supplicant interface state: disconnected -> scanning
08:24:06 grover NetworkManager[741]: <info> (wlan0): supplicant interface state: scanning -> authenticating
08:24:06 grover NetworkManager[741]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
08:24:08 grover kernel: [ 4875.131721] iwlwifi 0000:07:00.0: >fail to flush all tx fifo queues

Modules in question:
$ sudo lsmod |egrep 'iwl|wifi|802'
iwldvm                241608  0 
mac80211              540054  1 iwldvm
iwlwifi               103188  1 iwldvm
cfg80211              201717  3 iwlwifi,mac80211,iwldvm
rfkill                 21737  6 cfg80211,hp_wmi,bluetooth


Hardware in use:
$ lspci -vvv|grep Wireless
07:00.0 Network controller: Intel Corporation Centrino Wireless-N 1000
	Subsystem: Intel Corporation Centrino Wireless-N 1000 BGN

Comment 1 nmetro 2013-02-27 01:00:50 UTC
Same exact behavior with the following controller:

What happened was the wifi connection went away, iwconfig indicated that there was still an active wifi connection. Hitting F2, in teh Dell Studio 1745 keyboard, reset teh wifi and it came up normally. And indeed this can be reproduced and this usually ahppens after the laptop is inactive.

root@buckeyes1 ~]# lspci | grep "Link 5150"
08:00.0 Network controller: Intel Corporation WiMAX/WiFi Link 5150

[root@buckeyes1 ~]#  lsmod |egrep 'iwl|wifi|802'
iwldvm                241608  0 
mac80211              540054  1 iwldvm
iwlwifi               103188  1 iwldvm
cfg80211              201717  3 iwlwifi,mac80211,iwldvm
rfkill                 21737  6 cfg80211,wimax,bluetooth

[root@buckeyes1 ~]# uname -a
Linux buckeyes1.scarletandgray.info 3.7.9-101.fc17.x86_64 #1 SMP Mon Feb 18 22:04:06 UTC 2013 x86_64 x86_64 x86_64 GNU/Linux

[root@buckeyes1 ~]# cat /etc/redhat-release
Fedora release 17 (Beefy Miracle)

From /var/log/messages, when wifi went down:

Feb 24 17:27:33 buckeyes1 kernel: [74979.745493] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 24 17:27:33 buckeyes1 kernel: [74979.830452] ------------[ cut here ]------------
Feb 24 17:27:33 buckeyes1 kernel: [74979.830480] WARNING: at drivers/net/wireless/iwlwifi/dvm/tx.c:1187 iwlagn_rx_reply_tx+0x9b6/0x9
f0 [iwldvm]()
Feb 24 17:27:33 buckeyes1 kernel: [74979.830481] Hardware name: Studio 1749
Feb 24 17:27:33 buckeyes1 kernel: [74979.830482] Modules linked in: tcp_lp fuse lockd bnep bluetooth sunrpc be2iscsi iscsi_boot_sysf
s vboxpci(O) bnx2i vboxnetadp(O) cnic uio cxgb4i cxgb4 cxgb3i cxgb3 vboxnetflt(O) mdio libcxgbi ip6t_REJECT nf_conntrack_ipv6 vboxdr
v(O) nf_defrag_ipv6 xt_state ib_iser nf_conntrack ip6table_filter rdma_cm ib_addr iw_cm ib_cm ib_sa ib_mad ib_core iscsi_tcp ip6_tab
les libiscsi_tcp libiscsi scsi_transport_iscsi i2400m_usb uvcvideo i2400m videobuf2_vmalloc wimax videobuf2_memops videobuf2_core vi
deodev media snd_hda_codec_hdmi intel_ips snd_hda_codec_idt arc4 iwldvm mac80211 snd_hda_intel iwlwifi snd_hda_codec snd_hwdep mei v
host_net r8169 iTCO_wdt coretemp iTCO_vendor_support lpc_ich mfd_core tun macvtap macvlan mii snd_seq snd_seq_device snd_pcm cfg8021
1 rfkill snd_page_alloc snd_timer snd i2c_i801 kvm_intel microcode joydev soundcore dell_laptop dell_wmi sparse_keymap kvm dcdbas ec
ryptfs encrypted_keys binfmt_misc uinput trusted tpm tpm_bios crc32c_intel usb_storage firewire_ohci sdhci
Feb 24 17:27:33 buckeyes1 kernel: _pci sdhci mmc_core firewire_core crc_itu_t wmi i915 video i2c_algo_bit drm_kms_helper drm i2c_cor
e
Feb 24 17:27:33 buckeyes1 kernel: [74979.830541] Pid: 0, comm: swapper/1 Tainted: G         C O 3.6.11-5.fc17.x86_64 #1
Feb 24 17:27:33 buckeyes1 kernel: [74979.830542] Call Trace:
Feb 24 17:27:33 buckeyes1 kernel: [74979.830543]  <IRQ>  [<ffffffff8105c8ef>] warn_slowpath_common+0x7f/0xc0
Feb 24 17:27:33 buckeyes1 kernel: [74979.830552]  [<ffffffff8105c94a>] warn_slowpath_null+0x1a/0x20
Feb 24 17:27:33 buckeyes1 kernel: [74979.830558]  [<ffffffffa04613c6>] iwlagn_rx_reply_tx+0x9b6/0x9f0 [iwldvm]
Feb 24 17:27:33 buckeyes1 kernel: [74979.830565]  [<ffffffff810994c0>] ? load_balance+0x110/0x860
Feb 24 17:27:33 buckeyes1 kernel: [74979.830571]  [<ffffffffa046b193>] iwl_rx_dispatch+0xa3/0x110 [iwldvm]
Feb 24 17:27:33 buckeyes1 kernel: [74979.830578]  [<ffffffffa0394fa8>] iwl_irq_tasklet+0x7e8/0xba0 [iwlwifi]
Feb 24 17:27:33 buckeyes1 kernel: [74979.830583]  [<ffffffff81065a53>] tasklet_action+0x63/0xd0
Feb 24 17:27:33 buckeyes1 kernel: [74979.830585]  [<ffffffff810654c0>] __do_softirq+0xd0/0x210
Feb 24 17:27:33 buckeyes1 kernel: [74979.830589]  [<ffffffff8101b933>] ? native_sched_clock+0x13/0x80
Feb 24 17:27:33 buckeyes1 kernel: [74979.830593]  [<ffffffff816284fc>] call_softirq+0x1c/0x30
Feb 24 17:27:33 buckeyes1 kernel: [74979.830597]  [<ffffffff81016205>] do_softirq+0x75/0xb0
Feb 24 17:27:33 buckeyes1 kernel: [74979.830599]  [<ffffffff810658b5>] irq_exit+0xb5/0xc0
Feb 24 17:27:33 buckeyes1 kernel: [74979.830601]  [<ffffffff81628d53>] do_IRQ+0x63/0xe0
Feb 24 17:27:33 buckeyes1 kernel: [74979.830605]  [<ffffffff8161f62a>] common_interrupt+0x6a/0x6a
Feb 24 17:27:33 buckeyes1 kernel: [74979.830606]  <EOI>  [<ffffffff81338a7d>] ? intel_idle+0xed/0x150
Feb 24 17:27:33 buckeyes1 kernel: [74979.830612]  [<ffffffff81338a5e>] ? intel_idle+0xce/0x150
Feb 24 17:27:33 buckeyes1 kernel: [74979.830615]  [<ffffffff814cbf09>] cpuidle_enter+0x19/0x20
Feb 24 17:27:33 buckeyes1 kernel: [74979.830616]  [<ffffffff814cc599>] cpuidle_idle_call+0xa9/0x250
Feb 24 17:27:33 buckeyes1 kernel: [74979.830619]  [<ffffffff8101d52f>] cpu_idle+0xaf/0x120
Feb 24 17:27:33 buckeyes1 kernel: [74979.830621]  [<ffffffff8160df39>] start_secondary+0x23e/0x240
Feb 24 17:27:33 buckeyes1 kernel: [74979.830623] ---[ end trace 316ae49f2f0ece6d ]---
Feb 24 17:27:33 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:27:33 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:27:34 buckeyes1 kernel: [74979.932890] cfg80211: World regulatory domain updated:
Feb 24 17:27:34 buckeyes1 kernel: [74979.932895] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932899] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932902] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932905] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932907] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932910] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.932928] cfg80211: Calling CRDA for country: US
Feb 24 17:27:34 buckeyes1 kernel: [74979.935758] cfg80211: Regulatory domain changed to country: US
Feb 24 17:27:34 buckeyes1 kernel: [74979.935762] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935765] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935769] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935771] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935774] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935777] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935779] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:27:34 buckeyes1 kernel: [74979.935782] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:27:34 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: completed -> disconnected
Feb 24 17:27:35 buckeyes1 sh[832]: abrt-dump-oops: Found oopses: 1
Feb 24 17:27:35 buckeyes1 sh[832]: abrt-dump-oops: Creating problem directories
Feb 24 17:27:35 buckeyes1 abrt-dump-oops: Reported 1 kernel oopses to Abrt
Feb 24 17:27:35 buckeyes1 abrtd: Directory 'oops-2013-02-24-17:27:35-22615-1' creation detected
Feb 24 17:27:35 buckeyes1 abrtd: Can't find a meaningful backtrace for hashing in '.'
Feb 24 17:27:35 buckeyes1 abrtd: Looking for kernel package
Feb 24 17:27:35 buckeyes1 abrtd: Kernel package kernel-3.6.11-5.fc17.x86_64 found
Feb 24 17:27:35 buckeyes1 abrtd: New problem directory /var/spool/abrt/oops-2013-02-24-17:27:35-22615-1, processing
Feb 24 17:27:35 buckeyes1 kernel: [74981.846828] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 24 17:27:35 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 24 17:27:40 buckeyes1 kernel: [74986.177142] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 24 17:27:40 buckeyes1 kernel: [74986.179595] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:27:40 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 24 17:27:40 buckeyes1 kernel: [74986.238752] wlan0: authenticated
Feb 24 17:27:40 buckeyes1 kernel: [74986.239245] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:27:40 buckeyes1 kernel: [74986.240073] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 24 17:27:40 buckeyes1 kernel: [74986.241843] wlan0: associated
Feb 24 17:27:40 buckeyes1 kernel: [74986.241951] cfg80211: Calling CRDA for country: US
Feb 24 17:27:40 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:27:40 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:27:40 buckeyes1 kernel: [74986.267092] cfg80211: Regulatory domain changed to country: US
Feb 24 17:27:40 buckeyes1 kernel: [74986.267096] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267097] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267099] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267100] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267103] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267104] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:27:40 buckeyes1 kernel: [74986.267105] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:27:40 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: authenticating -> associated
Feb 24 17:27:40 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: associated -> completed
Feb 24 17:29:33 buckeyes1 kernel: [75099.537255] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 24 17:29:33 buckeyes1 kernel: [75099.565205] cfg80211: Calling CRDA to update world regulatory domain
Feb 24 17:29:33 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: completed -> disconnected
Feb 24 17:29:33 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:29:33 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:29:33 buckeyes1 kernel: [75099.582804] cfg80211: World regulatory domain updated:
Feb 24 17:29:33 buckeyes1 kernel: [75099.582807] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582809] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582810] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582812] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582813] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582814] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.582832] cfg80211: Calling CRDA for country: US
Feb 24 17:29:33 buckeyes1 kernel: [75099.585069] cfg80211: Regulatory domain changed to country: US
Feb 24 17:29:33 buckeyes1 kernel: [75099.585073] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585075] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585077] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585079] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585080] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585081] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585083] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:29:33 buckeyes1 kernel: [75099.585095] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:29:35 buckeyes1 kernel: [75101.563750] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 24 17:29:35 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 24 17:29:39 buckeyes1 kernel: [75104.862294] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 24 17:29:39 buckeyes1 kernel: [75104.865206] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:29:39 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 24 17:29:39 buckeyes1 kernel: [75104.917921] wlan0: authenticated
Feb 24 17:29:39 buckeyes1 kernel: [75104.918912] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:29:39 buckeyes1 kernel: [75104.919820] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 24 17:29:39 buckeyes1 kernel: [75104.922298] wlan0: associated
Feb 24 17:29:39 buckeyes1 kernel: [75104.922391] cfg80211: Calling CRDA for country: US
Feb 24 17:29:39 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: authenticating -> 4-way handshake
Feb 24 17:29:39 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:29:39 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:29:39 buckeyes1 kernel: [75104.942331] cfg80211: Regulatory domain changed to country: US
Feb 24 17:29:39 buckeyes1 kernel: [75104.942336] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942339] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942343] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942345] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942348] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942351] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942353] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:29:39 buckeyes1 kernel: [75104.942356] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.555715] iwlwifi 0000:08:00.0: RF_KILL bit toggled to disable radio.
Feb 24 17:29:40 buckeyes1 kernel: [75106.555819] wlan0: deauthenticating from b8:8d:12:62:a7:d6 by local choice (reason=3)
Feb 24 17:29:40 buckeyes1 kernel: [75106.569259] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569273] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569285] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569315] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569349] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569356] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.569480] cfg80211: Calling CRDA to update world regulatory domain
Feb 24 17:29:40 buckeyes1 kernel: [75106.574071] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 24 17:29:40 buckeyes1 kernel: [75106.580413] iwlwifi 0000:08:00.0: Failing on timeout while stopping DMA channel 1 [0xa5a5a5a2]
Feb 24 17:29:40 buckeyes1 kernel: [75106.586575] iwlwifi 0000:08:00.0: Failing on timeout while stopping DMA channel 3 [0xa5a5a5a2]
Feb 24 17:29:40 buckeyes1 kernel: [75106.592658] iwlwifi 0000:08:00.0: Failing on timeout while stopping DMA channel 4 [0xa5a5a5a2]
Feb 24 17:29:40 buckeyes1 kernel: [75106.598841] iwlwifi 0000:08:00.0: Failing on timeout while stopping DMA channel 6 [0xa5a5a5a2]
Feb 24 17:29:40 buckeyes1 kernel: [75106.599969] cfg80211: World regulatory domain updated:
Feb 24 17:29:40 buckeyes1 kernel: [75106.599972] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599974] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599976] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599978] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599980] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599982] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.599994] cfg80211: Calling CRDA for country: US
Feb 24 17:29:40 buckeyes1 kernel: [75106.602130] cfg80211: Regulatory domain changed to country: US
Feb 24 17:29:40 buckeyes1 kernel: [75106.602133] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602134] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602136] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602137] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602138] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602139] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602140] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.602142] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:29:40 buckeyes1 kernel: [75106.664204] usb 1-1.3: USB disconnect, device number 3
Feb 24 17:29:40 buckeyes1 kernel: [75106.664210] usb 1-1.3.1: USB disconnect, device number 5
Feb 24 17:29:40 buckeyes1 kernel: [75106.686035] usb 1-1.3.2: USB disconnect, device number 6
Feb 24 17:29:41 buckeyes1 NetworkManager[818]: <info> WiFi now disabled by radio killswitch
Feb 24 17:29:41 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: activated -> unavailable (reason 'none') [100 20
 0]



Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> WiFi now enabled by radio killswitch
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0): bringing up device.
Feb 24 17:29:46 buckeyes1 kernel: [75111.746256] iwlwifi 0000:08:00.0: L1 Enabled; Disabling L0S
Feb 24 17:29:46 buckeyes1 kernel: [75111.749312] iwlwifi 0000:08:00.0: Radio type=0x1-0x1-0x0
Feb 24 17:29:46 buckeyes1 kernel: [75111.797542] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0) supports 5 scan SSIDs
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: starting -> ready
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-
available') [20 30 42]
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <warn> Trying to remove a non-existant call id.
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: ready -> inactive
Feb 24 17:29:46 buckeyes1 NetworkManager[818]: <info> (wlan0) supports 5 scan SSIDs
Feb 24 17:29:48 buckeyes1 kernel: [75114.344872] usb 1-1.3: new full-speed USB device number 7 using ehci_hcd
Feb 24 17:29:48 buckeyes1 kernel: [75114.431981] usb 1-1.3: New USB device found, idVendor=0a5c, idProduct=4500
Feb 24 17:29:48 buckeyes1 kernel: [75114.431987] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb 24 17:29:48 buckeyes1 kernel: [75114.431991] usb 1-1.3: Product: BCM2046B1
Feb 24 17:29:48 buckeyes1 kernel: [75114.431994] usb 1-1.3: Manufacturer: Broadcom
Feb 24 17:29:48 buckeyes1 kernel: [75114.432493] hub 1-1.3:1.0: USB hub found
Feb 24 17:29:48 buckeyes1 kernel: [75114.432645] hub 1-1.3:1.0: 3 ports detected
Feb 24 17:29:48 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:29:48 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:29:49 buckeyes1 kernel: [75114.695310] usb 1-1.3.1: new full-speed USB device number 8 using ehci_hcd
Feb 24 17:29:49 buckeyes1 kernel: [75114.783610] usb 1-1.3.1: New USB device found, idVendor=413c, idProduct=8161
Feb 24 17:29:49 buckeyes1 kernel: [75114.783616] usb 1-1.3.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 24 17:29:49 buckeyes1 kernel: [75114.785837] input: HID 413c:8161 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.1/1-1
.3.1:1.0/input/input15
Feb 24 17:29:49 buckeyes1 kernel: [75114.786065] hid-generic 0003:413C:8161.0003: input,hidraw0: USB HID v1.11 Keyboard [HID 413c:81
61] on usb-0000:00:1a.0-1.3.1/input0
Feb 24 17:29:49 buckeyes1 kernel: [75114.858989] usb 1-1.3.2: new full-speed USB device number 9 using ehci_hcd
Feb 24 17:29:49 buckeyes1 kernel: [75114.937215] usb 1-1.3.2: New USB device found, idVendor=413c, idProduct=8162
Feb 24 17:29:49 buckeyes1 kernel: [75114.937222] usb 1-1.3.2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 24 17:29:49 buckeyes1 kernel: [75114.940298] input: HID 413c:8162 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.2/1-1
.3.2:1.0/input/input16
Feb 24 17:29:49 buckeyes1 kernel: [75114.940720] hid-generic 0003:413C:8162.0004: input,hidraw1: USB HID v1.11 Mouse [HID 413c:8162]
 on usb-0000:00:1a.0-1.3.2/input0
Feb 24 17:29:49 buckeyes1 mtp-probe: checking bus 1, device 8: "/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.1"
Feb 24 17:29:49 buckeyes1 mtp-probe: checking bus 1, device 9: "/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.2"
Feb 24 17:29:49 buckeyes1 mtp-probe: bus: 1, device: 8 was not an MTP device
Feb 24 17:29:49 buckeyes1 mtp-probe: bus: 1, device: 9 was not an MTP device
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Auto-activating connection 'Auto SPIRITOF76'.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) starting connection 'Auto SPIRITOF76'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0
]
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0/wireless): access point 'Auto SPIRITOF76' has security, but 
secrets are required.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0/wireless): connection 'Auto SPIRITOF76' has security, and se
crets exist.  No new secrets needed.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: added 'ssid' value 'SPIRITOF76'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: added 'scan_ssid' value '1'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: added 'psk' value '<omitted>'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: added 'proto' value 'WPA RSN'
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> Config: set interface ap_scan to 1
Feb 24 17:29:50 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: inactive -> scanning
Feb 24 17:29:55 buckeyes1 kernel: [75121.116053] wlan0: authenticate with b8:8d:12:62:a7:d5
Feb 24 17:29:55 buckeyes1 kernel: [75121.118496] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 1/3)
Feb 24 17:29:55 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 24 17:29:55 buckeyes1 kernel: [75121.318506] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 2/3)
Feb 24 17:29:55 buckeyes1 kernel: [75121.519187] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 3/3)
Feb 24 17:29:56 buckeyes1 kernel: [75121.719807] wlan0: authentication with b8:8d:12:62:a7:d5 timed out
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 24 17:29:56 buckeyes1 kernel: [75121.912987] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 24 17:29:56 buckeyes1 kernel: [75121.926227] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 24 17:29:56 buckeyes1 kernel: [75122.126174] wlan0: send auth to b8:8d:12:62:a7:d6 (try 2/3)
Feb 24 17:29:56 buckeyes1 kernel: [75122.126851] wlan0: authenticated
Feb 24 17:29:56 buckeyes1 kernel: [75122.128171] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 24 17:29:56 buckeyes1 kernel: [75122.129060] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 24 17:29:56 buckeyes1 kernel: [75122.131281] wlan0: associated
Feb 24 17:29:56 buckeyes1 kernel: [75122.131324] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 24 17:29:56 buckeyes1 kernel: [75122.131445] cfg80211: Calling CRDA for country: US
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: authenticating -> associated
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): supplicant interface state: associated -> completed
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Conne
cted to wireless network 'SPIRITOF76'.
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Beginning IP6 addrconf.
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Feb 24 17:29:56 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Feb 24 17:29:56 buckeyes1 avahi-daemon[850]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.13.
Feb 24 17:29:56 buckeyes1 avahi-daemon[850]: New relevant interface wlan0.IPv4 for mDNS.
Feb 24 17:29:56 buckeyes1 avahi-daemon[850]: Registering new address record for 192.168.100.13 on wlan0.IPv4.
Feb 24 17:29:56 buckeyes1 udevd[374]: unknown key 'SYSFS{idVendor}' in /etc/udev/rules.d/custom-concordance.rules:1
Feb 24 17:29:56 buckeyes1 udevd[374]: invalid rule '/etc/udev/rules.d/custom-concordance.rules:1'
Feb 24 17:29:56 buckeyes1 kernel: [75122.156634] cfg80211: Regulatory domain changed to country: US
Feb 24 17:29:56 buckeyes1 kernel: [75122.156638] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156640] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156641] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156642] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156644] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156645] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156646] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 24 17:29:56 buckeyes1 kernel: [75122.156647] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 24 17:29:57 buckeyes1 NetworkManager[818]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0
]
Feb 24 17:29:57 buckeyes1 NetworkManager[818]: <info> Policy set 'Auto SPIRITOF76' (wlan0) as default for IPv4 routing and DNS.
Feb 24 17:29:57 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) successful, device activated.
Feb 24 17:29:57 buckeyes1 NetworkManager[818]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.

Comment 2 nmetro 2013-02-27 01:18:59 UTC
An additional note, after using the F2 key, eventually the laptop stops responding and it requires a quick reset. That it, hit the power button to suspend and un-suspend the laptop. In more drastic situations, a full power restart is required.

A second log from today. In this log, there was no kernel crash, as noted above. The above log was generated from 3.7.6-102, below is from 3.7.9-101:

Feb 26 17:30:55 buckeyes1 kernel: [91202.163337] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:30:55 buckeyes1 kernel: [91202.250315] cfg80211: Calling CRDA to update world regulatory domain
Feb 26 17:30:55 buckeyes1 kernel: [91202.254869] cfg80211: World regulatory domain updated:
Feb 26 17:30:55 buckeyes1 kernel: [91202.254875] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254879] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254882] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254885] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254888] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254891] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.254914] cfg80211: Calling CRDA for country: US
Feb 26 17:30:55 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: completed -> disconnected
Feb 26 17:30:55 buckeyes1 kernel: [91202.257982] cfg80211: Regulatory domain changed to country: US
Feb 26 17:30:55 buckeyes1 kernel: [91202.257988] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:30:55 buckeyes1 kernel: [91202.257992] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.257995] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.257998] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.258001] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.258004] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.258007] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:30:55 buckeyes1 kernel: [91202.258010] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:30:55 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 26 17:30:59 buckeyes1 kernel: [91205.715978] wlan0: authenticate with b8:8d:12:62:a7:d5
Feb 26 17:30:59 buckeyes1 kernel: [91205.718676] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 1/3)
Feb 26 17:30:59 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 26 17:30:59 buckeyes1 kernel: [91205.918770] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 2/3)
Feb 26 17:30:59 buckeyes1 NetworkManager[856]: <info> (wlan0): roamed from BSSID B8:8D:12:62:A7:D6 (SPIRITOF76) to (none) ((none))
Feb 26 17:30:59 buckeyes1 kernel: [91206.119420] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 3/3)
Feb 26 17:30:59 buckeyes1 kernel: [91206.320072] wlan0: authentication with b8:8d:12:62:a7:d5 timed out
Feb 26 17:30:59 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Feb 26 17:31:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 26 17:31:00 buckeyes1 kernel: [91206.512597] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 26 17:31:00 buckeyes1 kernel: [91206.515148] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:31:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 26 17:31:00 buckeyes1 kernel: [91206.715342] wlan0: send auth to b8:8d:12:62:a7:d6 (try 2/3)
Feb 26 17:31:00 buckeyes1 kernel: [91206.715835] wlan0: authenticated
Feb 26 17:31:00 buckeyes1 kernel: [91206.716335] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:31:00 buckeyes1 kernel: [91206.717187] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 26 17:31:00 buckeyes1 kernel: [91206.718857] wlan0: associated
Feb 26 17:31:00 buckeyes1 kernel: [91206.718944] cfg80211: Calling CRDA for country: US
Feb 26 17:31:00 buckeyes1 kernel: [91206.721736] cfg80211: Regulatory domain changed to country: US
Feb 26 17:31:00 buckeyes1 kernel: [91206.721741] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721744] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721747] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721750] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721753] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721755] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721758] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:31:00 buckeyes1 kernel: [91206.721760] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:31:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: authenticating -> 4-way handshake
Feb 26 17:31:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Feb 26 17:31:00 buckeyes1 kernel: [91206.793412] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by b8:8d:12:62:a7:d6
Feb 26 17:31:05 buckeyes1 NetworkManager[856]: <info> (wlan0): roamed from BSSID (none) ((none)) to B8:8D:12:62:A7:D6 (SPIRITOF76)
Feb 26 17:31:51 buckeyes1 kernel: [91257.810994] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:31:53 buckeyes1 kernel: [91259.809535] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:31:55 buckeyes1 kernel: [91261.807081] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:31:57 buckeyes1 kernel: [91263.805619] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:31:59 buckeyes1 kernel: [91265.804161] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:01 buckeyes1 kernel: [91267.802697] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:03 buckeyes1 kernel: [91269.801279] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:05 buckeyes1 kernel: [91271.798845] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:07 buckeyes1 kernel: [91273.797344] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:09 buckeyes1 kernel: [91275.795834] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:11 buckeyes1 kernel: [91277.793355] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:13 buckeyes1 kernel: [91279.791920] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:15 buckeyes1 kernel: [91281.790464] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:17 buckeyes1 kernel: [91283.788007] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:19 buckeyes1 kernel: [91285.785589] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:21 buckeyes1 kernel: [91287.783123] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:23 buckeyes1 kernel: [91289.780648] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:25 buckeyes1 kernel: [91291.779179] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:27 buckeyes1 kernel: [91293.777716] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:29 buckeyes1 kernel: [91295.776250] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:31 buckeyes1 kernel: [91297.774867] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:33 buckeyes1 kernel: [91299.772326] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:35 buckeyes1 kernel: [91301.769894] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:37 buckeyes1 kernel: [91303.767472] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:39 buckeyes1 kernel: [91305.764957] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:41 buckeyes1 kernel: [91307.763477] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:43 buckeyes1 kernel: [91309.762027] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:45 buckeyes1 kernel: [91311.759603] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:47 buckeyes1 kernel: [91313.758190] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:49 buckeyes1 kernel: [91315.756716] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:51 buckeyes1 kernel: [91317.754195] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:52 buckeyes1 kernel: [91318.772251] iwlwifi 0000:08:00.0: RF_KILL bit toggled to disable radio.
Feb 26 17:32:52 buckeyes1 NetworkManager[856]: <info> WiFi now disabled by radio killswitch
Feb 26 17:32:52 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: activated -> unavailable (reason 'none') [100 20
 0]
Feb 26 17:32:52 buckeyes1 kernel: [91318.807282] usb 1-1.3: USB disconnect, device number 10
Feb 26 17:32:52 buckeyes1 kernel: [91318.807292] usb 1-1.3.1: USB disconnect, device number 11
Feb 26 17:32:52 buckeyes1 acpid: input device has been disconnected, fd 13
Feb 26 17:32:52 buckeyes1 kernel: [91318.828559] usb 1-1.3.2: USB disconnect, device number 12
Feb 26 17:32:52 buckeyes1 NetworkManager[856]: <info> (wlan0): deactivating device (reason 'none') [0]
Feb 26 17:32:53 buckeyes1 kernel: [91319.606063] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.606095] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.752787] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:32:53 buckeyes1 kernel: [91319.752942] wlan0: deauthenticating from b8:8d:12:62:a7:d6 by local choice (reason=3)
Feb 26 17:32:53 buckeyes1 kernel: [91319.752990] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.753002] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.753007] wlan0: failed to remove key (0, b8:8d:12:62:a7:d6) from hardware (-5)
Feb 26 17:32:53 buckeyes1 kernel: [91319.753030] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.753040] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.753046] iwlwifi 0000:08:00.0: Request scan called when driver not ready.
Feb 26 17:32:53 buckeyes1 kernel: [91319.760814] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.760824] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.760833] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.760920] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 kernel: [91319.760925] wlan0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5)
Feb 26 17:32:53 buckeyes1 kernel: [91319.777786] iwlwifi 0000:08:00.0: Not sending command - RF KILL
Feb 26 17:32:53 buckeyes1 avahi-daemon[897]: Interface wlan0.IPv4 no longer relevant for mDNS.
Feb 26 17:32:53 buckeyes1 kernel: [91319.778800] cfg80211: Calling CRDA to update world regulatory domain
Feb 26 17:32:53 buckeyes1 avahi-daemon[897]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.13.
Feb 26 17:32:53 buckeyes1 avahi-daemon[897]: Withdrawing address record for fe80::216:ebff:fe11:8da6 on wlan0.
Feb 26 17:32:53 buckeyes1 avahi-daemon[897]: Withdrawing address record for 192.168.100.13 on wlan0.
Feb 26 17:32:53 buckeyes1 kernel: [91319.783080] cfg80211: World regulatory domain updated:
Feb 26 17:32:53 buckeyes1 kernel: [91319.783086] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783090] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783093] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783096] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783099] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783102] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.783126] cfg80211: Calling CRDA for country: US
Feb 26 17:32:53 buckeyes1 kernel: [91319.786012] cfg80211: Regulatory domain changed to country: US
Feb 26 17:32:53 buckeyes1 kernel: [91319.786018] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786024] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786029] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786033] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786037] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786041] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786045] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:32:53 buckeyes1 kernel: [91319.786049] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:32:53 buckeyes1 dbus-daemon[935]: dbus[935]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servi
cehelper)
Feb 26 17:32:53 buckeyes1 dbus[935]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Feb 26 17:32:53 buckeyes1 dbus-daemon[935]: dbus[935]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Feb 26 17:32:53 buckeyes1 dbus[935]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Feb 26 17:32:53 buckeyes1 iscsi[28540]: Stopping iscsi: [  OK  ]
Feb 26 17:32:53 buckeyes1 dbus-daemon[935]: Stopping iscsi (via systemctl):  [  OK  ]
Feb 26 17:32:53 buckeyes1 chronyd[919]: Source 174.36.71.205 offline
Feb 26 17:32:53 buckeyes1 chronyd[919]: Source 209.114.111.1 offline
Feb 26 17:32:53 buckeyes1 chronyd[919]: Source 108.61.73.243 offline
Feb 26 17:32:53 buckeyes1 chronyd[919]: Source 204.2.134.163 offline
Feb 26 17:32:53 buckeyes1 dbus-daemon[935]: Restarting puppet (via systemctl):  [  OK  ]
Feb 26 17:33:00 buckeyes1 kernel: [91326.741564] iwlwifi 0000:08:00.0: RF_KILL bit toggled to enable radio.
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> WiFi now enabled by radio killswitch
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0): bringing up device.
Feb 26 17:33:00 buckeyes1 kernel: [91326.761443] iwlwifi 0000:08:00.0: L1 Enabled; Disabling L0S
Feb 26 17:33:00 buckeyes1 kernel: [91326.764502] iwlwifi 0000:08:00.0: Radio type=0x1-0x1-0x0
Feb 26 17:33:00 buckeyes1 kernel: [91326.902425] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0) supports 5 scan SSIDs
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: starting -> ready
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-
available') [20 30 42]
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <warn> Trying to remove a non-existant call id.
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: ready -> inactive
Feb 26 17:33:00 buckeyes1 NetworkManager[856]: <info> (wlan0) supports 5 scan SSIDs
Feb 26 17:33:00 buckeyes1 kernel: [91326.991499] usb 1-1.3: new full-speed USB device number 13 using ehci_hcd
Feb 26 17:33:00 buckeyes1 kernel: [91327.078639] usb 1-1.3: New USB device found, idVendor=0a5c, idProduct=4500
Feb 26 17:33:00 buckeyes1 kernel: [91327.078647] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb 26 17:33:00 buckeyes1 kernel: [91327.078653] usb 1-1.3: Product: BCM2046B1
Feb 26 17:33:00 buckeyes1 kernel: [91327.078659] usb 1-1.3: Manufacturer: Broadcom
Feb 26 17:33:00 buckeyes1 kernel: [91327.079117] hub 1-1.3:1.0: USB hub found
Feb 26 17:33:00 buckeyes1 kernel: [91327.079267] hub 1-1.3:1.0: 3 ports detected
Feb 26 17:33:01 buckeyes1 kernel: [91327.342897] usb 1-1.3.1: new full-speed USB device number 14 using ehci_hcd
Feb 26 17:33:01 buckeyes1 kernel: [91327.419825] usb 1-1.3.1: New USB device found, idVendor=413c, idProduct=8161
Feb 26 17:33:01 buckeyes1 kernel: [91327.419832] usb 1-1.3.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 26 17:33:01 buckeyes1 kernel: [91327.421963] input: HID 413c:8161 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.1/1-1
.3.1:1.0/input/input19
Feb 26 17:33:01 buckeyes1 kernel: [91327.422236] hid-generic 0003:413C:8161.0007: input,hidraw0: USB HID v1.11 Keyboard [HID 413c:81
61] on usb-0000:00:1a.0-1.3.1/input0
Feb 26 17:33:01 buckeyes1 kernel: [91327.484642] usb 1-1.3.2: new full-speed USB device number 15 using ehci_hcd
Feb 26 17:33:01 buckeyes1 kernel: [91327.562491] usb 1-1.3.2: New USB device found, idVendor=413c, idProduct=8162
Feb 26 17:33:01 buckeyes1 kernel: [91327.562497] usb 1-1.3.2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 26 17:33:01 buckeyes1 kernel: [91327.565690] input: HID 413c:8162 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.2/1-1
.3.2:1.0/input/input20
Feb 26 17:33:01 buckeyes1 kernel: [91327.566015] hid-generic 0003:413C:8162.0008: input,hidraw1: USB HID v1.11 Mouse [HID 413c:8162]
 on usb-0000:00:1a.0-1.3.2/input0
Feb 26 17:33:01 buckeyes1 mtp-probe: checking bus 1, device 15: "/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.2"
Feb 26 17:33:01 buckeyes1 mtp-probe: checking bus 1, device 14: "/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3.1"
Feb 26 17:33:01 buckeyes1 mtp-probe: bus: 1, device: 14 was not an MTP device
Feb 26 17:33:01 buckeyes1 mtp-probe: bus: 1, device: 15 was not an MTP device
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Auto-activating connection 'Auto SPIRITOF76'.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) starting connection 'Auto SPIRITOF76'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0
]
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0/wireless): access point 'Auto SPIRITOF76' has security, but 
secrets are required.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0/wireless): connection 'Auto SPIRITOF76' has security, and se
crets exist.  No new secrets needed.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: added 'ssid' value 'SPIRITOF76'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: added 'scan_ssid' value '1'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: added 'psk' value '<omitted>'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: added 'proto' value 'WPA RSN'
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> Config: set interface ap_scan to 1
Feb 26 17:33:05 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: inactive -> scanning
Feb 26 17:33:08 buckeyes1 kernel: [91334.542108] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 26 17:33:08 buckeyes1 kernel: [91334.545054] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 26 17:33:08 buckeyes1 kernel: [91334.745804] wlan0: send auth to b8:8d:12:62:a7:d6 (try 2/3)
Feb 26 17:33:08 buckeyes1 kernel: [91334.746345] wlan0: authenticated
Feb 26 17:33:08 buckeyes1 kernel: [91334.746794] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:33:08 buckeyes1 kernel: [91334.747632] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 26 17:33:08 buckeyes1 kernel: [91334.749829] wlan0: associated
Feb 26 17:33:08 buckeyes1 kernel: [91334.749873] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 26 17:33:08 buckeyes1 kernel: [91334.749988] cfg80211: Calling CRDA for country: US
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: authenticating -> 4-way handshake
Feb 26 17:33:08 buckeyes1 kernel: [91334.753447] cfg80211: Regulatory domain changed to country: US
Feb 26 17:33:08 buckeyes1 kernel: [91334.753454] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753459] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753464] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753468] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753472] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753477] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753481] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:33:08 buckeyes1 kernel: [91334.753485] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Conne
cted to wireless network 'SPIRITOF76'.
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Beginning IP6 addrconf.
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Feb 26 17:33:08 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Feb 26 17:33:08 buckeyes1 avahi-daemon[897]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.13.
Feb 26 17:33:08 buckeyes1 avahi-daemon[897]: New relevant interface wlan0.IPv4 for mDNS.
Feb 26 17:33:08 buckeyes1 avahi-daemon[897]: Registering new address record for 192.168.100.13 on wlan0.IPv4.
Feb 26 17:33:08 buckeyes1 kernel: [91334.777557] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by b8:8d:12:62:a7:d6
Feb 26 17:33:09 buckeyes1 NetworkManager[856]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0
]
Feb 26 17:33:09 buckeyes1 NetworkManager[856]: <info> Policy set 'Auto SPIRITOF76' (wlan0) as default for IPv4 routing and DNS.
Feb 26 17:33:09 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) successful, device activated.
Feb 26 17:33:09 buckeyes1 dbus[935]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Feb 26 17:33:09 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Feb 26 17:33:09 buckeyes1 dbus-daemon[935]: dbus[935]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servi
cehelper)
Feb 26 17:33:09 buckeyes1 dbus-daemon[935]: dbus[935]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Feb 26 17:33:09 buckeyes1 dbus[935]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Feb 26 17:33:09 buckeyes1 iscsi[28679]: Starting iscsi: iscsiadm: No records found
Feb 26 17:33:09 buckeyes1 iscsi[28679]: [  OK  ]
Feb 26 17:33:09 buckeyes1 dbus-daemon[935]: Starting iscsi (via systemctl):  [  OK  ]
Feb 26 17:33:10 buckeyes1 dbus-daemon[935]: disabled
Feb 26 17:33:10 buckeyes1 chronyd[919]: Source 174.36.71.205 online
Feb 26 17:33:10 buckeyes1 chronyd[919]: Source 209.114.111.1 online
Feb 26 17:33:10 buckeyes1 chronyd[919]: Source 204.2.134.163 online
Feb 26 17:33:10 buckeyes1 chronyd[919]: Source 108.61.73.243 online
Feb 26 17:33:10 buckeyes1 dbus-daemon[935]: Restarting puppet (via systemctl):  [  OK  ]
Feb 26 17:33:10 buckeyes1 avahi-daemon[897]: Registering new address record for fe80::216:ebff:fe11:8da6 on wlan0.*.
Feb 26 17:33:28 buckeyes1 NetworkManager[856]: <info> (wlan0): IP6 addrconf timed out or failed.
Feb 26 17:33:28 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
Feb 26 17:33:28 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) started...
Feb 26 17:33:28 buckeyes1 NetworkManager[856]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
Feb 26 17:34:26 buckeyes1 kernel: [91412.774846] iwlwifi 0000:08:00.0: fail to flush all tx fifo queues
Feb 26 17:34:26 buckeyes1 kernel: [91412.842880] cfg80211: Calling CRDA to update world regulatory domain
Feb 26 17:34:26 buckeyes1 kernel: [91412.845924] cfg80211: World regulatory domain updated:
Feb 26 17:34:26 buckeyes1 kernel: [91412.845927] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845929] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845930] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845932] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845933] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845934] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.845948] cfg80211: Calling CRDA for country: US
Feb 26 17:34:26 buckeyes1 kernel: [91412.847878] cfg80211: Regulatory domain changed to country: US
Feb 26 17:34:26 buckeyes1 kernel: [91412.847881] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847882] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847884] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847885] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847887] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847888] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847889] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:34:26 buckeyes1 kernel: [91412.847890] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:34:26 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: completed -> disconnected
Feb 26 17:34:26 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 26 17:34:30 buckeyes1 kernel: [91416.092713] wlan0: authenticate with b8:8d:12:62:a7:d5
Feb 26 17:34:30 buckeyes1 kernel: [91416.101248] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 1/3)
Feb 26 17:34:30 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 26 17:34:30 buckeyes1 kernel: [91416.301835] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 2/3)
Feb 26 17:34:30 buckeyes1 kernel: [91416.502477] wlan0: direct probe to b8:8d:12:62:a7:d5 (try 3/3)
Feb 26 17:34:30 buckeyes1 kernel: [91416.703123] wlan0: authentication with b8:8d:12:62:a7:d5 timed out
Feb 26 17:34:30 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Feb 26 17:34:30 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Feb 26 17:34:33 buckeyes1 kernel: [91419.670739] wlan0: authenticate with b8:8d:12:62:a7:d6
Feb 26 17:34:33 buckeyes1 kernel: [91419.673325] wlan0: send auth to b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:34:33 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Feb 26 17:34:33 buckeyes1 kernel: [91419.729068] wlan0: authenticated
Feb 26 17:34:33 buckeyes1 kernel: [91419.729855] wlan0: associate with b8:8d:12:62:a7:d6 (try 1/3)
Feb 26 17:34:33 buckeyes1 kernel: [91419.730723] wlan0: RX AssocResp from b8:8d:12:62:a7:d6 (capab=0x1511 status=0 aid=3)
Feb 26 17:34:33 buckeyes1 kernel: [91419.732751] wlan0: associated
Feb 26 17:34:33 buckeyes1 kernel: [91419.732856] cfg80211: Calling CRDA for country: US
Feb 26 17:34:33 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: authenticating -> 4-way handshake
Feb 26 17:34:33 buckeyes1 kernel: [91419.735726] cfg80211: Regulatory domain changed to country: US
Feb 26 17:34:33 buckeyes1 kernel: [91419.735731] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735735] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735739] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735742] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735745] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735748] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735751] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
Feb 26 17:34:33 buckeyes1 kernel: [91419.735753] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
Feb 26 17:34:33 buckeyes1 NetworkManager[856]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Feb 26 17:34:33 buckeyes1 kernel: [91419.827878] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by b8:8d:12:62:a7:d6

Comment 3 nmetro 2013-03-07 00:15:38 UTC
It looks like this issue could be the result of Wireless N being turned on. And it looks like this problem has existed for a rather long time, based upon some of the internet posts I have seen.

So, the following should at least make things a bit stable:

echo "options iwlwifi 11n_disable=1" /etc/modprobe.d/iwlwifi.conf

Then, reboot.

This configuration will support both 2.4 and 5 Ghz on G; not N.

Unfortunately, you can only get a maximum of 56 Mbs.

Also, it does not stop "iwlwifi 0000:08:00.0: fail to flush all tx fifo queues" messages from occurring, but it seems to be bit more stable.
 
Ideally, the driver needs to be fixed to properly support Wireless N.

Comment 4 nmetro 2013-03-07 23:04:13 UTC
I had a couple typos:

The command should be:

echo "options iwlwifi 11n_disable=1" > /etc/modprobe.d/iwlwifi.conf

Also, the speed is 54 Mbs, not 56 Mbs.

After a day running in this configuration, I have not lost wireless connectivit completely. It does drop, for a split second, when it gets a "fail to flush", but they occur about three times a day as opposed to several times a day and a complete loss of connection.

Again, this is not an ideal solution, because one loses "N" speed and this solution hides the real problem.

Comment 5 Erick 2013-03-08 11:54:42 UTC
This problem is also present in F18 and also for the rt2800usb driver (iwlwifi module not loaded on my system). 

Related modules loaded:

rt2800usb              22366  0 
rt2x00usb              19200  1 rt2800usb
rt2800lib              59421  1 rt2800usb
rt2x00lib              56186  3 rt2x00usb,rt2800lib,rt2800usb
mac80211              499595  3 rt2x00lib,rt2x00usb,rt2800lib
cfg80211              425812  2 mac80211,rt2x00lib
crc_ccitt              12549  1 rt2800lib

Comment 6 Erick 2013-03-08 17:19:30 UTC
Additional info: after finding another possible bug here on bugzilla I kept a ping running to the AP and since then the connection hasn´t dropped anymore for the last 3 hours (before this ping, the connection dropped multiple times per hour).

Comment 7 Stanislaw Gruszka 2013-03-12 13:16:41 UTC
(In reply to comment #0)
> 3. Sleep laptop and resume
> 4. Re-load modules

That strange, because reloading modules should initialize hardware the same as reboot do. Could you provide full dmesg output after reproducing the problem , one with case where modules are reloaded, and one with case where modules are not touched.

Comment 8 M Miller 2013-03-13 01:32:07 UTC
Created attachment 709261 [details]
DMESG output with modules still loaded

Comment 9 M Miller 2013-03-13 01:32:41 UTC
Created attachment 709262 [details]
DMESG output with modules removed

Comment 10 M Miller 2013-03-13 01:38:48 UTC
Stanislaw Gruszka,

Thanks for checking this out.  I've attached my dmesg output for both situations.

Here's the output from removing the modules... who knows, maybe I'm not going deep enough or pulling enough out for a full re-initialization.

$ lsmod|egrep 'iwl|802|wifi'
iwldvm                241608  0 
mac80211              540054  1 iwldvm
iwlwifi               103188  1 iwldvm
cfg80211              201717  3 iwlwifi,mac80211,iwldvm
rfkill                 21737  6 cfg80211,hp_wmi,bluetooth

$ sudo modprobe -r iwldvm
$ sudo modprobe -r mac80211
$ sudo modprobe -r iwlwifi
$ sudo modprobe -r cf80211
$ sudo modprobe -r rfkill

I'll then reload in reverse order, of course.

Let me know if you need more info!

Comment 11 Stanislaw Gruszka 2013-03-13 08:08:13 UTC
That really weird, looks like antenna stop working or we do not sent frames with proper TX power (or AP gone, or we did something that AP stop authenticate us) ?

Does scan work after resume from suspend? I.e. what show below command (need to be run with root privileges) after suspend, does it differ from results before suspend ?

iw dev wlan0 scan

Comment 12 M Miller 2013-03-14 19:53:20 UTC
This happens on any access point 100% of the time.  System attempts to reconnect to wireless but after a period of time, the wireless passphrase prompt pops up.

$ sudo iw dev wlan0 scan
command failed: Device or resource busy (-16)

Logs are showing what looks like an inability to authenticate with the good/stored password:

Mar 14 12:50:02 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Mar 14 12:50:02 grover kernel: [ 8844.523872] wlan0: authenticate with 08:17:35:62:53:53
Mar 14 12:50:02 grover kernel: [ 8844.525294] wlan0: direct probe to 08:17:35:62:53:53 (try 1/3)
Mar 14 12:50:02 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Mar 14 12:50:02 grover kernel: [ 8844.726170] wlan0: direct probe to 08:17:35:62:53:53 (try 2/3)
Mar 14 12:50:02 grover kernel: [ 8844.927083] wlan0: direct probe to 08:17:35:62:53:53 (try 3/3)
Mar 14 12:50:02 grover kernel: [ 8845.127983] wlan0: authentication with 08:17:35:62:53:53 timed out
Mar 14 12:50:02 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Mar 14 12:50:03 grover NetworkManager[822]: <warn> Activation (wlan0/wireless): association took too long.
Mar 14 12:50:03 grover NetworkManager[822]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Mar 14 12:50:03 grover NetworkManager[822]: <warn> Activation (wlan0/wireless): asking for new secrets
Mar 14 12:50:04 grover kernel: [ 8847.129110] iwlwifi 0000:07:00.0: fail to flush all tx fifo queues
Mar 14 12:50:04 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Mar 14 12:50:04 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: scanning -> disconnected
Mar 14 12:50:04 grover NetworkManager[822]: <info> (wlan0): supplicant interface state: disconnected -> inactive
Mar 14 12:50:05 grover dnsmasq[1017]: reading /etc/resolv.conf
Mar 14 12:50:05 grover dnsmasq[1017]: using nameserver 172.18.10.66#53
Mar 14 12:50:05 grover dnsmasq[1017]: using nameserver 172.18.10.65#53
Mar 14 12:50:05 grover dnsmasq[1017]: using nameserver 172.23.200.2#53
Mar 14 12:50:05 grover dnsmasq[1017]: using nameserver 172.23.200.1#53
Mar 14 12:50:05 grover dnsmasq[1017]: using local addresses only for unqualified names
Mar 14 12:50:10 grover NetworkManager[822]: <warn> No agents were available for this request.
Mar 14 12:50:10 grover NetworkManager[822]: <info> (wlan0): device state change: need-auth -> failed (reason 'no-secrets') [60 120 7]
Mar 14 12:50:10 grover NetworkManager[822]: <info> Marking connection 'WIRELESS' invalid.
Mar 14 12:50:10 grover NetworkManager[822]: <warn> Activation (wlan0) failed for connection 'WIRELESS'
Mar 14 12:50:10 grover NetworkManager[822]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 14 12:50:10 grover NetworkManager[822]: <info> (wlan0): deactivating device (reason 'none') [0]

Comment 13 Stanislaw Gruszka 2013-03-18 12:48:41 UTC
If you repeat a few times "sudo iw dev wlan0 scan" does it show some networks ?

Comment 14 M Miller 2013-03-19 21:28:28 UTC
Created attachment 712976 [details]
Scan Output from iw command

It seems I scanned to soon previously.  If I wait for the connection to error out, I am able to scan with no issues... I just can't seem to connect to WPA2 type networks (that's all I can test on currently).

Comment 15 Stanislaw Gruszka 2013-03-21 12:52:59 UTC
Ok, so we are able to receive frames after suspend, but not necessary able to transmit frames. I have a theory: after suspend laptop firmware assert COEX (BT or WiMAX coexistense) line and that prevent wifi driver to TX. 

Please try to load module with coexistence disabled, i.e:

modprobe iwlwifi bt_coex_active=0

and check if that helps.

Comment 16 M Miller 2013-03-21 14:12:22 UTC
WOW.  That was almost too easy to implement!

I've added that option to a modprode.d file.  I now have wireless after suspend!

Thanks Stanislaw!

I'll have to do some digging on that module to get to know some of the module options better.  Wouldn't have even known where to start.  Nice theory!

Comment 17 Stanislaw Gruszka 2013-03-21 14:36:35 UTC
I'm closing this bug report, it is laptop firmware/hardware problem. You can try to update BIOS to make issue gone without bt_coex_active=0 workaround.

Comment 18 M Miller 2013-03-21 16:35:54 UTC
Sounds good.

Thanks again!


Note You need to log in before you can comment on or make changes to this bug.