You are not logged in.
- Topics: Active | Unanswered
#1 2017-10-06 00:48:36
- NickHack997
- Member
- Registered: 2017-10-06
- Posts: 3
[SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
TL;DR: Fixed in Kernel 4.13.5 which is now in testing
Hello,
first time posting so wasn't entirely sure where to post this, but probably a newbie question.
First install of Arch was running smoothly for 6 months, but last Thursday I had severe problems with kworker hanging, NetworkManager and wpa_supplicant refusing to stop on shutdown/reboot, and suspend instantly waking. So I decided a reinstall would potentially be a good decision, and I'm getting the same problems (leads me to believe this is probably wifi driver related or wifi card). Not sure how to resolve this after trying all weekend searching to try and find a permanent solution.
I have tried using netctl/wicd to see if the problem is NetworkManager and they also refuse to stop on reboot/shutdown.
Laptop: Acer Aspire E5-575G
Kernel: 4.13.3-1
WM: i3-gaps
The issue:
I read somewhere that this can be commonplace and therefore should be ignored, but in my case it's spammed in journal -xe constantly even when not running pacman. Also the post stated that it's potentially a memory issue, but I don't see that being the case free -h
free -h:
total used free shared buff/cache available
Mem: 7.7G 1.4G 5.4G 234M 1.0G 5.9G
Swap: 2.0G 0B 2.0Gthis is with Firefox (all the tabs) and termite open so it doesn't seem RAM is the issue SSD failure I haven't tested.
journal -xe
Oct 05 20:26:25 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:26:25 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:26:25 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:28:28 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:28:28 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:28:28 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:30:30 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:30:30 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:30:30 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:32:33 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:32:33 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:32:33 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:34:36 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:34:36 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:34:36 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:36:39 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:36:39 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:36:39 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:38:42 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:38:42 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:38:42 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:40:45 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:40:45 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:40:45 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:42:48 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:42:48 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:42:48 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 05 20:44:51 Arch2 kernel: INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
Oct 05 20:44:51 Arch2 kernel: Tainted: G O 4.13.3-1-ARCH #1
Oct 05 20:44:51 Arch2 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.Suspend also freezes and instantly resumes log states that NetworkManager and wpa_supplicant are the culprit no idea where to start for fixing that.
systemd-suspend.service log:
[ 121.705232] Freezing of tasks failed after 20.004 seconds (2 tasks refusing to freeze, wq_busy=0):
[ 121.705262] NetworkManager D 0 293 1 0x00000004
[ 121.705268] Call Trace:
[ 121.705281] __schedule+0x239/0x890
[ 121.705287] schedule+0x3d/0x90
[ 121.705291] schedule_preempt_disabled+0x15/0x20
[ 121.705296] __mutex_lock.isra.2+0x295/0x520
[ 121.705302] __mutex_lock_slowpath+0x13/0x20
[ 121.705306] ? __mutex_lock_slowpath+0x13/0x20
[ 121.705310] mutex_lock+0x25/0x30
[ 121.705335] __ieee80211_stop_tx_ba_session+0x27/0x50 [mac80211]
[ 121.705356] ieee80211_sta_tear_down_BA_sessions+0x32/0x70 [mac80211]
[ 121.705373] __sta_info_destroy_part1+0x3c/0x480 [mac80211]
[ 121.705390] __sta_info_flush+0xd9/0x190 [mac80211]
[ 121.705416] ieee80211_set_disassoc+0xba/0x3c0 [mac80211]
[ 121.705440] ieee80211_mgd_deauth+0x118/0x230 [mac80211]
[ 121.705465] ieee80211_deauth+0x18/0x20 [mac80211]
[ 121.705484] cfg80211_mlme_deauth+0xa9/0x1f0 [cfg80211]
[ 121.705500] cfg80211_mlme_down+0x66/0x80 [cfg80211]
[ 121.705516] cfg80211_disconnect+0xfe/0x200 [cfg80211]
[ 121.705529] __cfg80211_leave+0x136/0x170 [cfg80211]
[ 121.705541] cfg80211_leave+0x2b/0x40 [cfg80211]
[ 121.705553] cfg80211_netdev_notifier_call+0x337/0x630 [cfg80211]
[ 121.705561] ? default_wake_function+0x12/0x20
[ 121.705567] ? gen_replace_estimator+0x10/0x10
[ 121.705574] ? inetdev_event+0x46/0x4c0
[ 121.705579] ? skb_dequeue+0x59/0x70
[ 121.705584] notifier_call_chain+0x4a/0x70
[ 121.705589] raw_notifier_call_chain+0x16/0x20
[ 121.705595] call_netdevice_notifiers_info+0x35/0x60
[ 121.705601] __dev_close_many+0x55/0x100
[ 121.705607] __dev_close+0x45/0x70
[ 121.705612] __dev_change_flags+0x9d/0x160
[ 121.705617] dev_change_flags+0x29/0x60
[ 121.705622] do_setlink+0x2f7/0xe60
[ 121.705627] ? __wake_up+0x44/0x50
[ 121.705633] ? netlink_broadcast_filtered+0x14b/0x3a0
[ 121.705638] ? nlmsg_notify+0x54/0xd0
[ 121.705643] ? nla_parse+0x35/0x110
[ 121.705648] rtnl_newlink+0x5d2/0x8f0
[ 121.705659] ? security_capset+0x80/0x80
[ 121.705666] ? ns_capable_common+0x68/0x80
[ 121.705672] ? ns_capable+0x13/0x20
[ 121.705677] rtnetlink_rcv_msg+0x1a3/0x200
[ 121.705683] ? lookup_fast+0xcc/0x310
[ 121.705687] ? rtnl_newlink+0x8f0/0x8f0
[ 121.705692] netlink_rcv_skb+0x91/0x130
[ 121.705696] rtnetlink_rcv+0x28/0x30
[ 121.705700] netlink_unicast+0x1a4/0x240
[ 121.705705] netlink_sendmsg+0x2b8/0x3b0
[ 121.705709] ? netlink_unicast+0x240/0x240
[ 121.705717] ___sys_sendmsg+0x2b6/0x310
[ 121.705724] ? _crng_backtrack_protect+0x60/0x80
[ 121.705728] ? memzero_explicit+0xe/0x10
[ 121.705733] ? urandom_read+0x127/0x290
[ 121.705741] ? __fget+0x6e/0x90
[ 121.705745] __sys_sendmsg+0x54/0x90
[ 121.705749] ? __sys_sendmsg+0x54/0x90
[ 121.705754] SyS_sendmsg+0x12/0x20
[ 121.705760] entry_SYSCALL_64_fastpath+0x1a/0xa5
[ 121.705764] RIP: 0033:0x7fcaf3828ad4
[ 121.705767] RSP: 002b:00007fff5ec2fab0 EFLAGS: 00000293 ORIG_RAX: 000000000000002e
[ 121.705771] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fcaf3828ad4
[ 121.705773] RDX: 0000000000000000 RSI: 00007fff5ec2fb00 RDI: 0000000000000007
[ 121.705775] RBP: 0000000000000010 R08: 0000000000000000 R09: 000055e58c4a2fa0
[ 121.705778] R10: 000055e58c4a2fa0 R11: 0000000000000293 R12: 00007fff5ec2ffc2
[ 121.705780] R13: 0000000000000006 R14: 000055e58ac02f00 R15: 0000000000000003
[ 121.705789] wpa_supplicant D 0 334 1 0x00000004
[ 121.705794] Call Trace:
[ 121.705799] __schedule+0x239/0x890
[ 121.705804] ? __free_pages+0x1f/0x30
[ 121.705808] schedule+0x3d/0x90
[ 121.705813] schedule_preempt_disabled+0x15/0x20
[ 121.705817] __mutex_lock.isra.2+0x295/0x520
[ 121.705825] ? ___slab_alloc+0xef/0x4c0
[ 121.705831] __mutex_lock_slowpath+0x13/0x20
[ 121.705835] ? __mutex_lock_slowpath+0x13/0x20
[ 121.705839] mutex_lock+0x25/0x30
[ 121.705842] rtnl_lock+0x15/0x20
[ 121.705859] nl80211_pre_doit+0xf5/0x190 [cfg80211]
[ 121.705865] genl_family_rcv_msg+0x1be/0x3e0
[ 121.705872] genl_rcv_msg+0x4c/0x90
[ 121.705876] ? genl_family_rcv_msg+0x3e0/0x3e0
[ 121.705880] netlink_rcv_skb+0x91/0x130
[ 121.705885] genl_rcv+0x28/0x40
[ 121.705888] netlink_unicast+0x1a4/0x240
[ 121.705893] netlink_sendmsg+0x2b8/0x3b0
[ 121.705897] ? netlink_unicast+0x240/0x240
[ 121.705904] ___sys_sendmsg+0x2b6/0x310
[ 121.705909] ? __set_task_blocked+0x3c/0xa0
[ 121.705913] ? __set_current_blocked+0x55/0x60
[ 121.705919] ? do_signal+0x19b/0x680
[ 121.705926] ? __fpu__restore_sig+0x96/0x530
[ 121.705931] __sys_sendmsg+0x54/0x90
[ 121.705935] ? __sys_sendmsg+0x54/0x90
[ 121.705940] SyS_sendmsg+0x12/0x20
[ 121.705945] entry_SYSCALL_64_fastpath+0x1a/0xa5
[ 121.705948] RIP: 0033:0x7fc63b5a53d7
[ 121.705950] RSP: 002b:00007ffde8682e88 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
[ 121.705954] RAX: ffffffffffffffda RBX: 000000000000001d RCX: 00007fc63b5a53d7
[ 121.705956] RDX: 0000000000000000 RSI: 00007ffde8682ec0 RDI: 0000000000000005
[ 121.705958] RBP: 0000561f86962a98 R08: 0000000000000000 R09: 0000000000000000
[ 121.705960] R10: 0000561f86985450 R11: 0000000000000246 R12: 0000000000000001
[ 121.705962] R13: 00007ffde86834f8 R14: 000000000000000b R15: 0000561f86903410This for whatever reason also makes it impossible to restart NetworkManager or wpa_supplicant after the failed suspend even
systemctl restart NetworkManager/wpa_supplicant doesn't work and just causes them to fail and be killed by Systemd
wpa_supplicant log:
● wpa_supplicant.service - WPA supplicant
Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant.service; disabled; vendor preset: disabled)
Active: active (running) since Tue 2017-10-03 11:48:48 EDT; 3min 36s ago
Main PID: 729 (wpa_supplicant)
Tasks: 1 (limit: 4915)
CGroup: /system.slice/wpa_supplicant.service
└─729 /usr/bin/wpa_supplicant -u
Oct 03 11:50:29 Arch2 wpa_supplicant[729]: nl80211: deinit ifname=wlp3s0 disabled_11b_rates=0
Oct 03 11:50:33 Arch2 wpa_supplicant[729]: Could not set interface wlp3s0 flags (UP): Input/output error
Oct 03 11:50:33 Arch2 wpa_supplicant[729]: WEXT: Could not set interface 'wlp3s0' UP
Oct 03 11:50:33 Arch2 wpa_supplicant[729]: wlp3s0: Failed to initialize driver interface
Oct 03 11:50:48 Arch2 wpa_supplicant[729]: Could not set interface wlp3s0 flags (UP): Input/output error
Oct 03 11:50:48 Arch2 wpa_supplicant[729]: nl80211: Could not set interface 'wlp3s0' UP
Oct 03 11:50:48 Arch2 wpa_supplicant[729]: nl80211: deinit ifname=wlp3s0 disabled_11b_rates=0
Oct 03 11:50:52 Arch2 wpa_supplicant[729]: Could not set interface wlp3s0 flags (UP): Input/output error
Oct 03 11:50:52 Arch2 wpa_supplicant[729]: WEXT: Could not set interface 'wlp3s0' UP
Oct 03 11:50:52 Arch2 wpa_supplicant[729]: wlp3s0: Failed to initialize driver interfacedhcpcd also fails and refuses to restart as well
dhcpcd log:
● dhcpcd.service - dhcpcd on all interfaces
Loaded: loaded (/usr/lib/systemd/system/dhcpcd.service; disabled; vendor preset: disabled)
Active: failed (Result: timeout) since Wed 2017-10-04 22:58:59 EDT; 27s ago
Tasks: 1 (limit: 4915)
CGroup: /system.slice/dhcpcd.service
└─2073 /usr/bin/dhcpcd -q -b
Oct 04 22:58:38 Arch2 systemd[1]: dhcpcd.service: Start operation timed out. Terminating.
Oct 04 22:58:43 Arch2 systemd[1]: dhcpcd.service: State 'stop-sigterm' timed out. Killing.
Oct 04 22:58:43 Arch2 systemd[1]: dhcpcd.service: Killing process 2073 (dhcpcd) with signal SIGKILL.
Oct 04 22:58:49 Arch2 systemd[1]: dhcpcd.service: Processes still around after SIGKILL. Ignoring.
Oct 04 22:58:54 Arch2 systemd[1]: dhcpcd.service: State 'stop-final-sigterm' timed out. Killing.
Oct 04 22:58:54 Arch2 systemd[1]: dhcpcd.service: Killing process 2073 (dhcpcd) with signal SIGKILL.
Oct 04 22:58:59 Arch2 systemd[1]: dhcpcd.service: Processes still around after final SIGKILL. Entering failed mode.
Oct 04 22:58:59 Arch2 systemd[1]: Failed to start dhcpcd on all interfaces.
Oct 04 22:58:59 Arch2 systemd[1]: dhcpcd.service: Unit entered failed state.
Oct 04 22:58:59 Arch2 systemd[1]: dhcpcd.service: Failed with result 'timeout'.Any assistance would be greatly appreciated no idea how to resolve these issues. Also posting dmesg on boot just in case there's an obvious wifi related error there that I don't understand. Note this isn't all of it
dmesg:
[ 0.624577] pci_bus 0000:01: resource 0 [io 0x4000-0x4fff]
[ 0.624577] pci_bus 0000:01: resource 1 [mem 0x93000000-0x940fffff]
[ 0.624578] pci_bus 0000:01: resource 2 [mem 0x80000000-0x91ffffff 64bit pref]
[ 0.624580] pci_bus 0000:03: resource 1 [mem 0x94200000-0x943fffff]
[ 0.624581] pci_bus 0000:04: resource 0 [io 0x3000-0x3fff]
[ 0.624582] pci_bus 0000:04: resource 1 [mem 0x94400000-0x944fffff]
[ 0.624712] NET: Registered protocol family 2
[ 0.624841] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.624948] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.625090] TCP: Hash tables configured (established 65536 bind 65536)
[ 0.625115] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.625137] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.625180] NET: Registered protocol family 1
[ 0.625191] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 0.626798] PCI: CLS 64 bytes, default 64
[ 0.626829] Unpacking initramfs...
[ 0.740787] Freeing initrd memory: 7968K
[ 0.740829] DMAR: ACPI device "device:69" under DMAR at fed91000 as 00:15.0
[ 0.740838] DMAR: No ATSR found
[ 0.741156] DMAR: dmar0: Using Queued invalidation
[ 0.741160] DMAR: dmar1: Using Queued invalidation
[ 0.741277] DMAR: Setting RMRR:
[ 0.741324] DMAR: Setting identity map for device 0000:00:02.0 [0x79000000 - 0x7d7fffff]
[ 0.741349] DMAR: Setting identity map for device 0000:00:14.0 [0x77c7b000 - 0x77c9afff]
[ 0.741355] DMAR: Prepare 0-16MiB unity mapping for LPC
[ 0.741376] DMAR: Setting identity map for device 0000:00:1f.0 [0x0 - 0xffffff]
[ 0.741387] DMAR: Intel(R) Virtualization Technology for Directed I/O
[ 0.741429] iommu: Adding device 0000:00:00.0 to group 0
[ 0.741436] iommu: Adding device 0000:00:02.0 to group 1
[ 0.741448] iommu: Adding device 0000:00:14.0 to group 2
[ 0.741454] iommu: Adding device 0000:00:14.2 to group 2
[ 0.741464] iommu: Adding device 0000:00:15.0 to group 3
[ 0.741474] iommu: Adding device 0000:00:16.0 to group 4
[ 0.741480] iommu: Adding device 0000:00:17.0 to group 5
[ 0.741491] iommu: Adding device 0000:00:1c.0 to group 6
[ 0.741511] iommu: Adding device 0000:00:1d.0 to group 7
[ 0.741521] iommu: Adding device 0000:00:1d.2 to group 7
[ 0.741531] iommu: Adding device 0000:00:1d.3 to group 7
[ 0.741546] iommu: Adding device 0000:00:1f.0 to group 8
[ 0.741553] iommu: Adding device 0000:00:1f.2 to group 8
[ 0.741559] iommu: Adding device 0000:00:1f.3 to group 8
[ 0.741566] iommu: Adding device 0000:00:1f.4 to group 8
[ 0.741571] iommu: Adding device 0000:01:00.0 to group 6
[ 0.741577] iommu: Adding device 0000:03:00.0 to group 7
[ 0.741583] iommu: Adding device 0000:04:00.0 to group 7
[ 0.741588] iommu: Adding device 0000:04:00.1 to group 7
[ 0.743179] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns
[ 0.743286] Scanning for low memory corruption every 60 seconds
[ 0.743836] Initialise system trusted keyrings
[ 0.743844] Key type blacklist registered
[ 0.743915] workingset: timestamp_bits=40 max_order=21 bucket_order=0
[ 0.744810] zbud: loaded
[ 0.746036] Key type asymmetric registered
[ 0.746064] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 0.746128] io scheduler noop registered
[ 0.746129] io scheduler deadline registered
[ 0.746150] io scheduler cfq registered (default)
[ 0.746151] io scheduler mq-deadline registered
[ 0.746152] io scheduler kyber registered
[ 0.746170] io scheduler bfq registered
[ 0.746951] efifb: probing for efifb
[ 0.746966] efifb: framebuffer at 0xa0000000, using 8100k, total 8100k
[ 0.746967] efifb: mode is 1920x1080x32, linelength=7680, pages=1
[ 0.746968] efifb: scrolling: redraw
[ 0.746969] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
[ 0.751158] Console: switching to colour frame buffer device 240x67
[ 0.755225] fb0: EFI VGA frame buffer device
[ 0.755231] intel_idle: MWAIT substates: 0x11142120
[ 0.755232] intel_idle: v0.4.1 model 0x4E
[ 0.755458] intel_idle: lapic_timer_reliable_states 0xffffffff
[ 0.755680] GHES: HEST is not enabled!
[ 0.755775] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.756363] Linux agpgart interface v0.103
[ 0.756718] rtc_cmos 00:03: RTC can wake from S4
[ 0.757144] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[ 0.757225] rtc_cmos 00:03: alarms up to one month, y3k, 242 bytes nvram, hpet irqs
[ 0.757230] intel_pstate: Intel P-state driver initializing
[ 0.757682] intel_pstate: HWP enabled
[ 0.757908] ledtrig-cpu: registered to indicate activity on CPUs
[ 0.757947] vlv2_plat_clk vlv2_plat_clk: vlv2_plat_clk initialized
[ 0.758142] NET: Registered protocol family 10
[ 0.761287] Segment Routing with IPv6
[ 0.761304] NET: Registered protocol family 17
[ 0.761638] RAS: Correctable Errors collector initialized.
[ 0.761669] microcode: sig=0x406e3, pf=0x80, revision=0xba
[ 0.761774] microcode: Microcode Update Driver: v2.2.
[ 0.761782] sched_clock: Marking stable (761769518, 0)->(762248376, -478858)
[ 0.762066] registered taskstats version 1
[ 0.762071] Loading compiled-in X.509 certificates
[ 0.762084] zswap: loaded using pool lzo/zbud
[ 0.763009] Magic number: 5:294:354
[ 0.763171] rtc_cmos 00:03: setting system clock to 2017-10-06 00:22:20 UTC (1507249340)
[ 0.763697] PM: Hibernation image not present or could not be loaded.
[ 0.764713] Freeing unused kernel memory: 1328K
[ 0.764714] Write protecting the kernel read-only data: 10240k
[ 0.765026] Freeing unused kernel memory: 1576K
[ 0.765062] Freeing unused kernel memory: 12K
[ 0.879499] i8042: PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
[ 0.879500] i8042: PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[ 0.881699] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.890679] ACPI: bus type USB registered
[ 0.890701] usbcore: registered new interface driver usbfs
[ 0.890711] usbcore: registered new interface driver hub
[ 0.890732] usbcore: registered new device driver usb
[ 0.890834] SCSI subsystem initialized
[ 0.892071] libata version 3.00 loaded.
[ 0.892360] xhci_hcd 0000:00:14.0: xHCI Host Controller
[ 0.892370] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1
[ 0.893656] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x00109810
[ 0.893670] xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
[ 0.893896] hub 1-0:1.0: USB hub found
[ 0.893926] hub 1-0:1.0: 12 ports detected
[ 0.895199] xhci_hcd 0000:00:14.0: xHCI Host Controller
[ 0.895203] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2
[ 0.895348] hub 2-0:1.0: USB hub found
[ 0.895369] hub 2-0:1.0: 6 ports detected
[ 0.895729] usb: port power management may be unreliable
[ 0.896153] ahci 0000:00:17.0: version 3.0
[ 0.906565] ahci 0000:00:17.0: AHCI 0001.0301 32 slots 3 ports 6 Gbps 0x7 impl SATA mode
[ 0.906567] ahci 0000:00:17.0: flags: 64bit ncq pm led clo only pio slum part deso sadm sds apst
[ 0.907119] scsi host0: ahci
[ 0.907224] scsi host1: ahci
[ 0.907337] scsi host2: ahci
[ 0.907381] ata1: SATA max UDMA/133 abar m2048@0x9452d000 port 0x9452d100 irq 16
[ 0.907385] ata2: SATA max UDMA/133 abar m2048@0x9452d000 port 0x9452d180 irq 16
[ 0.907389] ata3: SATA max UDMA/133 abar m2048@0x9452d000 port 0x9452d200 irq 16
[ 0.917625] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 1.221742] ata1: SATA link down (SStatus 4 SControl 300)
[ 1.224496] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.224728] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 1.227432] ata3.00: ATA-9: LITEON CV1-8B256, G881201, max UDMA/133
[ 1.227440] ata3.00: 500118192 sectors, multi 1: LBA48 NCQ (depth 31/32), AA
[ 1.228002] ata3.00: configured for UDMA/133
[ 1.228395] ata2.00: ATAPI: Slimtype DVD A DA8AESH, XA11, max UDMA/133
[ 1.229188] ata2.00: configured for UDMA/133
[ 1.236572] scsi 1:0:0:0: CD-ROM Slimtype DVD A DA8AESH XA11 PQ: 0 ANSI: 5
[ 1.253289] scsi 2:0:0:0: Direct-Access ATA LITEON CV1-8B256 201 PQ: 0 ANSI: 5
[ 1.270033] usb 1-5: new full-speed USB device number 2 using xhci_hcd
[ 1.312218] sd 2:0:0:0: [sda] 500118192 512-byte logical blocks: (256 GB/238 GiB)
[ 1.312232] sd 2:0:0:0: [sda] Write Protect is off
[ 1.312235] sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.312252] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.313875] sda: sda1 sda2 sda3 sda4
[ 1.314703] sd 2:0:0:0: [sda] Attached SCSI disk
[ 1.335848] random: crng init done
[ 1.339431] sr 1:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[ 1.339434] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 1.340281] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 1.530183] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null)
[ 1.626707] usb 1-7: new high-speed USB device number 3 using xhci_hcd
[ 1.658996] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 1.666821] systemd[1]: systemd 234 running in system mode. (+PAM -AUDIT -SELINUX -IMA -APPARMOR +SMACK -SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN default-hierarchy=hybrid)
[ 1.666938] systemd[1]: Detected architecture x86-64.
[ 1.667137] systemd[1]: Set hostname to <Arch2>.
[ 1.750627] systemd[1]: Created slice System Slice.
[ 1.750822] systemd[1]: Created slice User and Session Slice.
[ 1.750892] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 1.750957] systemd[1]: Listening on LVM2 metadata daemon socket.
[ 1.751027] systemd[1]: Listening on Journal Socket.
[ 1.751528] systemd[1]: Mounting POSIX Message Queue File System...
[ 1.752051] systemd[1]: Mounting Huge Pages File System...
[ 1.756891] clocksource: Switched to clocksource tsc
[ 1.765057] EXT4-fs (sda3): re-mounted. Opts: data=ordered
[ 1.777412] Key type trusted registered
[ 1.782339] Key type encrypted registered
[ 1.805071] systemd-journald[166]: Received request to flush runtime journal from PID 1
[ 1.815815] systemd-journald[166]: File /var/log/journal/10b4ca7b05c54bc88e905af4fc145381/system.journal corrupted or uncleanly shut down, renaming and replacing.
[ 1.869284] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[ 1.872207] mei_me 0000:00:16.0: enabling device (0000 -> 0002)
[ 1.872838] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
[ 1.872846] ACPI: Power Button [PWRB]
[ 1.872887] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2
[ 1.872893] ACPI: Sleep Button [SLPB]
[ 1.872963] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input3
[ 1.872993] ACPI: Lid Switch [LID0]
[ 1.873034] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4
[ 1.873047] ACPI: Power Button [PWRF]
[ 1.886998] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 1.887463] intel-lpss 0000:00:15.0: enabling device (0000 -> 0002)
[ 1.894324] ACPI: AC Adapter [ACAD] (on-line)
[ 1.894499] idma64 idma64.0: Found Intel integrated DMA 64-bit
[ 1.895586] ACPI: Battery Slot [BAT1] (battery present)
[ 1.897875] i801_smbus 0000:00:1f.4: SPD Write Disable is set
[ 1.897906] i801_smbus 0000:00:1f.4: SMBus using PCI interrupt
[ 1.922252] wmi_bus wmi_bus-PNP0C14:00: WQ data block query control method not found
[ 1.922255] wmi_bus wmi_bus-PNP0C14:00: WQ data block query control method not found
[ 1.922256] wmi_bus wmi_bus-PNP0C14:00: WQ data block query control method not found
[ 1.922750] wmi_bus wmi_bus-PNP0C14:00: WQ data block query control method not found
[ 1.956144] hidraw: raw HID events driver (C) Jiri Kosina
[ 1.959728] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[ 1.959833] thermal LNXTHERM:00: registered as thermal_zone1
[ 1.959835] ACPI: Thermal Zone [TZ01] (39 C)
[ 1.987114] input: PC Speaker as /devices/platform/pcspkr/input/input5
[ 2.005199] Bluetooth: Core ver 2.22
[ 2.005211] NET: Registered protocol family 31
[ 2.005212] Bluetooth: HCI device and connection manager initialized
[ 2.005215] Bluetooth: HCI socket layer initialized
[ 2.005217] Bluetooth: L2CAP socket layer initialized
[ 2.005221] Bluetooth: SCO socket layer initialized
[ 2.008070] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
[ 2.008076] r8169 0000:04:00.1: can't disable ASPM; OS doesn't have ASPM control
[ 2.014650] RAPL PMU: API unit is 2^-32 Joules, 5 fixed counters, 655360 ms ovfl timer
[ 2.014652] RAPL PMU: hw unit of domain pp0-core 2^-14 Joules
[ 2.014653] RAPL PMU: hw unit of domain package 2^-14 Joules
[ 2.014654] RAPL PMU: hw unit of domain dram 2^-14 Joules
[ 2.014655] RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules
[ 2.014655] RAPL PMU: hw unit of domain psys 2^-14 Joules
[ 2.017688] r8169 0000:04:00.1 eth0: RTL8411 at 0xffffb36f40e3d000, 54:ab:3a:98:6a:9e, XID 1c800800 IRQ 19
[ 2.017691] r8169 0000:04:00.1 eth0: jumbo features [frames: 9200 bytes, tx checksumming: ko]
[ 2.018820] Adding 2097148k swap on /dev/sda2. Priority:-1 extents:1 across:2097148k SSFS
[ 2.031418] usbcore: registered new interface driver btusb
[ 2.040581] ath10k_pci 0000:03:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
[ 2.075187] AVX2 version of gcm_enc/dec engaged.
[ 2.075188] AES CTR mode by8 optimization enabled
[ 2.076289] [drm] Memory usable by graphics device = 4096M
[ 2.076291] [drm] VT-d active for gfx access
[ 2.076292] checking generic (a0000000 7e9000) vs hw (a0000000 10000000)
[ 2.076293] fb: switching to inteldrmfb from EFI VGA
[ 2.076313] Console: switching to colour dummy device 80x25
[ 2.076419] [drm] Replacing VGA console driver
[ 2.084862] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 2.084864] [drm] Driver supports precise vblank timestamp query.
[ 2.088811] iTCO_vendor_support: vendor-support=0
[ 2.089752] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
[ 2.089920] iTCO_wdt: Found a Intel PCH TCO device (Version=4, TCOBASE=0x0400)
[ 2.090523] [drm] Disabling framebuffer compression (FBC) to prevent screen flicker with VT-d enabled
[ 2.090807] i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem
[ 2.092621] [drm] Finished loading DMC firmware i915/skl_dmc_ver1_26.bin (v1.26)
[ 2.094352] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[ 2.110679] r8169 0000:04:00.1 enp4s0f1: renamed from eth0
[ 2.114899] media: Linux media interface: v0.10
[ 2.118256] acer_wmi: Acer Laptop ACPI-WMI Extras
[ 2.118280] acer_wmi: Function bitmap for Communication Button: 0x801
[ 2.128487] input: Acer WMI hotkeys as /devices/virtual/input/input6
[ 2.141888] Linux video capture interface: v2.00
[ 2.168928] uvcvideo: Found UVC 1.00 device HD WebCam (0bda:57f2)
[ 2.174098] intel_rapl: Found RAPL domain package
[ 2.174100] intel_rapl: Found RAPL domain core
[ 2.174113] intel_rapl: Found RAPL domain uncore
[ 2.174114] intel_rapl: Found RAPL domain dram
[ 2.177489] hid-multitouch 0018:04F3:3019.0001: Ignoring the extra HID_DG_INPUTMODE
[ 2.177553] input: ELAN0501:00 04F3:3019 Touchpad as /devices/pci0000:00/0000:00:15.0/i2c_designware.0/i2c-0/i2c-ELAN0501:00/0018:04F3:3019.0001/input/input9
[ 2.177868] hid-multitouch 0018:04F3:3019.0001: input,hidraw0: I2C HID v1.00 Mouse [ELAN0501:00 04F3:3019] on i2c-ELAN0501:00
[ 2.189346] [drm] Initialized i915 1.6.0 20170619 for 0000:00:02.0 on minor 0
[ 2.199104] uvcvideo 1-7:1.0: Entity type for entity Extension 4 was not initialized!
[ 2.199106] uvcvideo 1-7:1.0: Entity type for entity Processing 2 was not initialized!
[ 2.199107] uvcvideo 1-7:1.0: Entity type for entity Camera 1 was not initialized!
[ 2.203068] mousedev: PS/2 mouse device common for all mice
[ 2.206620] input: HD WebCam: HD WebCam as /devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/input/input10
[ 2.207101] usbcore: registered new interface driver uvcvideo
[ 2.207102] USB Video Class driver (1.1.1)
[ 2.208992] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no)
[ 2.209170] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input11
[ 2.209395] [Firmware Bug]: ACPI(PXSX) defines _DOD but not _DOS
[ 2.209403] ACPI: Video Device [PXSX] (multi-head: yes rom: yes post: no)
[ 2.209431] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:32/LNXVIDEO:01/input/input12
[ 2.209531] snd_hda_intel 0000:00:1f.3: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915])
[ 2.219757] fbcon: inteldrmfb (fb0) is primary device
[ 2.225212] EXT4-fs (sda4): mounted filesystem with ordered data mode. Opts: data=ordered
[ 2.259391] bbswitch: loading out-of-tree module taints kernel.
[ 2.259598] bbswitch: version 0.8
[ 2.259602] bbswitch: Found integrated VGA device 0000:00:02.0: \_SB_.PCI0.GFX0
[ 2.259606] bbswitch: Found discrete VGA device 0000:01:00.0: \_SB_.PCI0.RP01.PXSX
[ 2.259614] ACPI Warning: \_SB.PCI0.RP01.PXSX._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20170531/nsarguments-95)
[ 2.259698] bbswitch: detected an Optimus _DSM function
[ 2.259709] pci 0000:01:00.0: enabling device (0006 -> 0007)
[ 2.259786] bbswitch: Succesfully loaded. Discrete card 0000:01:00.0 is on
[ 2.261051] bbswitch: disabling discrete graphics
[ 2.261061] ACPI Warning: \_SB.PCI0.RP01.PXSX._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20170531/nsarguments-95)
[ 2.298326] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC255: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:speaker
[ 2.298328] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[ 2.298329] snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x21/0x0/0x0/0x0/0x0)
[ 2.298330] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0
[ 2.298330] snd_hda_codec_realtek hdaudioC0D0: inputs:
[ 2.298332] snd_hda_codec_realtek hdaudioC0D0: Headset Mic=0x19
[ 2.298333] snd_hda_codec_realtek hdaudioC0D0: Internal Mic=0x12
[ 2.304816] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 2.305552] Unable to find dmi tokens
[ 2.333641] snd_hda_codec_realtek hdaudioC0D0: Failed to find dell wmi symbol dell_micmute_led_set
[ 2.385712] input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1f.3/sound/card0/input13
[ 2.386897] input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:1f.3/sound/card0/input14
[ 2.387378] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input15
[ 2.387418] input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input16
[ 2.387455] input: HDA Intel PCH HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input17
[ 2.387488] input: HDA Intel PCH HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input18
[ 2.387521] input: HDA Intel PCH HDMI/DP,pcm=10 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input19
[ 2.404971] ath10k_pci 0000:03:00.0: qca9377 hw1.1 target 0x05020001 chip_id 0x003821ff sub 11ad:08a6
[ 2.404972] ath10k_pci 0000:03:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 0 testmode 0
[ 2.405377] ath10k_pci 0000:03:00.0: firmware ver WLAN.TF.1.0-00267-1 api 5 features ignore-otp crc32 79cea2c7
[ 2.469899] ath10k_pci 0000:03:00.0: board_file api 2 bmi_id N/A crc32 8aedfa4a
[ 2.581695] IPv6: ADDRCONF(NETDEV_UP): enp4s0f1: link is not ready
[ 2.598945] r8169 0000:04:00.1 enp4s0f1: link down
[ 2.598994] IPv6: ADDRCONF(NETDEV_UP): enp4s0f1: link is not ready
[ 2.951496] ath10k_pci 0000:03:00.0: htt-ver 3.1 wmi-op 4 htt-op 3 cal otp max-sta 32 raw 0 hwcrypto 1
[ 2.957732] ath: EEPROM regdomain: 0x69
[ 2.957733] ath: EEPROM indicates we should expect a direct regpair map
[ 2.957734] ath: Country alpha2 being used: 00
[ 2.957734] ath: Regpair used: 0x69
[ 2.964121] ath10k_pci 0000:03:00.0 wlp3s0: renamed from wlan0
[ 2.984351] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
[ 3.330292] [drm] RC6 on
[ 3.535421] Console: switching to colour frame buffer device 240x67
[ 3.555433] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[ 3.653694] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
[ 4.329672] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
[ 4.424692] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
[ 5.040951] fuse init (API version 7.26)
[ 9.046933] IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
[ 12.887692] ath10k_pci 0000:03:00.0: no channel configured; ignoring frame(s)!
[ 13.653921] wlp3s0: authenticate with 34:fc:b9:11:c0:b0
[ 13.691027] wlp3s0: send auth to 34:fc:b9:11:c0:b0 (try 1/3)
[ 13.692412] wlp3s0: authenticated
[ 13.723347] wlp3s0: associate with 34:fc:b9:11:c0:b0 (try 1/3)
[ 13.724712] wlp3s0: RX AssocResp from 34:fc:b9:11:c0:b0 (capab=0x411 status=0 aid=3)
[ 13.726977] wlp3s0: associated
[ 13.727000] IPv6: ADDRCONF(NETDEV_CHANGE): wlp3s0: link becomes ready
[ 245.383389] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 245.383407] Tainted: G O 4.13.3-1-ARCH #1
[ 245.383413] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 245.383445] kworker/u8:1 D 0 50 2 0x00000000
[ 245.383546] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 245.383575] Call Trace:
[ 245.383593] __schedule+0x239/0x890
[ 245.383605] schedule+0x3d/0x90
[ 245.383635] schedule_preempt_disabled+0x15/0x20
[ 245.383643] __mutex_lock.isra.2+0x295/0x520
[ 245.383655] __mutex_lock_slowpath+0x13/0x20
[ 245.383662] ? __mutex_lock_slowpath+0x13/0x20
[ 245.383669] mutex_lock+0x25/0x30
[ 245.383710] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 245.383723] ? dequeue_entity+0xed/0x4d0
[ 245.383754] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 245.383766] process_one_work+0x1de/0x430
[ 245.383796] worker_thread+0x47/0x3f0
[ 245.383808] kthread+0x125/0x140
[ 245.383814] ? process_one_work+0x430/0x430
[ 245.383824] ? kthread_create_on_node+0x70/0x70
[ 245.383834] ret_from_fork+0x25/0x30
[ 368.263336] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 368.263354] Tainted: G O 4.13.3-1-ARCH #1
[ 368.263361] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 368.263370] kworker/u8:1 D 0 50 2 0x00000000
[ 368.263428] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 368.263436] Call Trace:
[ 368.263455] __schedule+0x239/0x890
[ 368.263467] schedule+0x3d/0x90
[ 368.263476] schedule_preempt_disabled+0x15/0x20
[ 368.263484] __mutex_lock.isra.2+0x295/0x520
[ 368.263497] __mutex_lock_slowpath+0x13/0x20
[ 368.263506] ? __mutex_lock_slowpath+0x13/0x20
[ 368.263513] mutex_lock+0x25/0x30
[ 368.263557] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 368.263573] ? dequeue_entity+0xed/0x4d0
[ 368.263612] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 368.263624] process_one_work+0x1de/0x430
[ 368.263632] worker_thread+0x47/0x3f0
[ 368.263643] kthread+0x125/0x140
[ 368.263650] ? process_one_work+0x430/0x430
[ 368.263660] ? kthread_create_on_node+0x70/0x70
[ 368.263671] ret_from_fork+0x25/0x30
[ 491.143247] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 491.143253] Tainted: G O 4.13.3-1-ARCH #1
[ 491.143254] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 491.143256] kworker/u8:1 D 0 50 2 0x00000000
[ 491.143274] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 491.143276] Call Trace:
[ 491.143283] __schedule+0x239/0x890
[ 491.143286] schedule+0x3d/0x90
[ 491.143288] schedule_preempt_disabled+0x15/0x20
[ 491.143290] __mutex_lock.isra.2+0x295/0x520
[ 491.143294] __mutex_lock_slowpath+0x13/0x20
[ 491.143296] ? __mutex_lock_slowpath+0x13/0x20
[ 491.143297] mutex_lock+0x25/0x30
[ 491.143307] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 491.143311] ? dequeue_entity+0xed/0x4d0
[ 491.143321] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 491.143325] process_one_work+0x1de/0x430
[ 491.143327] worker_thread+0x47/0x3f0
[ 491.143330] kthread+0x125/0x140
[ 491.143332] ? process_one_work+0x430/0x430
[ 491.143335] ? kthread_create_on_node+0x70/0x70
[ 491.143338] ret_from_fork+0x25/0x30
[ 614.023329] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 614.023344] Tainted: G O 4.13.3-1-ARCH #1
[ 614.023348] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 614.023354] kworker/u8:1 D 0 50 2 0x00000000
[ 614.023404] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 614.023409] Call Trace:
[ 614.023424] __schedule+0x239/0x890
[ 614.023432] schedule+0x3d/0x90
[ 614.023439] schedule_preempt_disabled+0x15/0x20
[ 614.023445] __mutex_lock.isra.2+0x295/0x520
[ 614.023455] __mutex_lock_slowpath+0x13/0x20
[ 614.023460] ? __mutex_lock_slowpath+0x13/0x20
[ 614.023466] mutex_lock+0x25/0x30
[ 614.023498] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 614.023509] ? dequeue_entity+0xed/0x4d0
[ 614.023540] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 614.023549] process_one_work+0x1de/0x430
[ 614.023557] worker_thread+0x47/0x3f0
[ 614.023570] kthread+0x125/0x140
[ 614.023577] ? process_one_work+0x430/0x430
[ 614.023587] ? kthread_create_on_node+0x70/0x70
[ 614.023598] ret_from_fork+0x25/0x30
[ 736.903403] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 736.903417] Tainted: G O 4.13.3-1-ARCH #1
[ 736.903422] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 736.903428] kworker/u8:1 D 0 50 2 0x00000000
[ 736.903476] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 736.903482] Call Trace:
[ 736.903497] __schedule+0x239/0x890
[ 736.903506] schedule+0x3d/0x90
[ 736.903513] schedule_preempt_disabled+0x15/0x20
[ 736.903519] __mutex_lock.isra.2+0x295/0x520
[ 736.903529] __mutex_lock_slowpath+0x13/0x20
[ 736.903535] ? __mutex_lock_slowpath+0x13/0x20
[ 736.903540] mutex_lock+0x25/0x30
[ 736.903573] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 736.903584] ? dequeue_entity+0xed/0x4d0
[ 736.903614] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 736.903625] process_one_work+0x1de/0x430
[ 736.903632] worker_thread+0x47/0x3f0
[ 736.903643] kthread+0x125/0x140
[ 736.903650] ? process_one_work+0x430/0x430
[ 736.903661] ? kthread_create_on_node+0x70/0x70
[ 736.903671] ret_from_fork+0x25/0x30
[ 859.783448] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 859.783461] Tainted: G O 4.13.3-1-ARCH #1
[ 859.783465] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 859.783470] kworker/u8:1 D 0 50 2 0x00000000
[ 859.783510] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 859.783515] Call Trace:
[ 859.783529] __schedule+0x239/0x890
[ 859.783536] schedule+0x3d/0x90
[ 859.783542] schedule_preempt_disabled+0x15/0x20
[ 859.783547] __mutex_lock.isra.2+0x295/0x520
[ 859.783555] __mutex_lock_slowpath+0x13/0x20
[ 859.783561] ? __mutex_lock_slowpath+0x13/0x20
[ 859.783565] mutex_lock+0x25/0x30
[ 859.783596] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 859.783682] ? dequeue_entity+0xed/0x4d0
[ 859.783708] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 859.783717] process_one_work+0x1de/0x430
[ 859.783723] worker_thread+0x47/0x3f0
[ 859.783731] kthread+0x125/0x140
[ 859.783736] ? process_one_work+0x430/0x430
[ 859.783743] ? kthread_create_on_node+0x70/0x70
[ 859.783751] ret_from_fork+0x25/0x30
[ 982.663213] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 982.663228] Tainted: G O 4.13.3-1-ARCH #1
[ 982.663232] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 982.663238] kworker/u8:1 D 0 50 2 0x00000000
[ 982.663284] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 982.663289] Call Trace:
[ 982.663304] __schedule+0x239/0x890
[ 982.663313] schedule+0x3d/0x90
[ 982.663319] schedule_preempt_disabled+0x15/0x20
[ 982.663326] __mutex_lock.isra.2+0x295/0x520
[ 982.663335] __mutex_lock_slowpath+0x13/0x20
[ 982.663340] ? __mutex_lock_slowpath+0x13/0x20
[ 982.663346] mutex_lock+0x25/0x30
[ 982.663376] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 982.663386] ? dequeue_entity+0xed/0x4d0
[ 982.663413] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 982.663423] process_one_work+0x1de/0x430
[ 982.663429] worker_thread+0x47/0x3f0
[ 982.663439] kthread+0x125/0x140
[ 982.663444] ? process_one_work+0x430/0x430
[ 982.663452] ? kthread_create_on_node+0x70/0x70
[ 982.663461] ret_from_fork+0x25/0x30
[ 1105.543166] INFO: task kworker/u8:1:50 blocked for more than 120 seconds.
[ 1105.543174] Tainted: G O 4.13.3-1-ARCH #1
[ 1105.543177] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1105.543180] kworker/u8:1 D 0 50 2 0x00000000
[ 1105.543204] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 1105.543207] Call Trace:
[ 1105.543215] __schedule+0x239/0x890
[ 1105.543219] schedule+0x3d/0x90
[ 1105.543222] schedule_preempt_disabled+0x15/0x20
[ 1105.543226] __mutex_lock.isra.2+0x295/0x520
[ 1105.543230] __mutex_lock_slowpath+0x13/0x20
[ 1105.543233] ? __mutex_lock_slowpath+0x13/0x20
[ 1105.543236] mutex_lock+0x25/0x30
[ 1105.543251] __ieee80211_start_rx_ba_session+0x153/0x520 [mac80211]
[ 1105.543257] ? dequeue_entity+0xed/0x4d0
[ 1105.543271] ieee80211_ba_session_work+0x164/0x250 [mac80211]
[ 1105.543276] process_one_work+0x1de/0x430
[ 1105.543279] worker_thread+0x47/0x3f0
[ 1105.543284] kthread+0x125/0x140
[ 1105.543287] ? process_one_work+0x430/0x430
[ 1105.543291] ? kthread_create_on_node+0x70/0x70
[ 1105.543295] ret_from_fork+0x25/0x30*EDIT on shutdown the system unmounts and stops everything, eventually, but it just hangs when it reaches shutdown and then starts spamming the kworker issue again, and eventually shuts down 5 minutes later.
- NickHack997
Last edited by NickHack997 (2017-10-06 14:34:22)
Offline
#2 2017-10-06 01:56:55
- natervance
- Member
- Registered: 2017-04-20
- Posts: 53
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
I am also experiencing a similar issue. I believe that this was reported here:
https://bugs.archlinux.org/task/55872
The submitter of the above bug report has a Qualcomm Atheros QCA9377 802.11ac Wireless Network Adapter (rev 31), and as do I. Do you happen to have the same one as well? (lspci shows this info)
Further evidence that this issue is caused by the wireless network adapter is that, if I disable it, the problem goes away. Of course, that leaves me with no wifi, which is a poor tradeoff. But, if you would rather connect over ethernet until this gets fixed, go for it.
As an aside, I attempted to register for Arch's bugtracker so that I could confirm this issue there, but there seems to be a bug in the registration process. Exceedingly ironic, and reminiscent of https://www.xkcd.com/1163/. If anyone who has an existing account there happens to see this, could you mention the detail about the network adapter there?
Offline
#3 2017-10-06 01:57:22
- circleface
- Member
- Registered: 2012-05-26
- Posts: 639
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
Since there seems to be a problem with NetworkManager and dhcp, try disabling those manually first, then see if the suspend works.
Offline
#4 2017-10-06 02:05:36
- NickHack997
- Member
- Registered: 2017-10-06
- Posts: 3
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
natervance wrote:
I am also experiencing a similar issue. I believe that this was reported here:
https://bugs.archlinux.org/task/55872
The submitter of the above bug report has a Qualcomm Atheros QCA9377 802.11ac Wireless Network Adapter (rev 31), and as do I. Do you happen to have the same one as well? (lspci shows this info)
Yep.
lspci
03:00.0 Network controller: Qualcomm Atheros QCA9377 802.11ac Wireless Network Adapter (rev 31)I'll try and register. Any idea when this is will be fixed or a temporary fix? It's not a system breaking bug, but it's incredibly annoying.
*Edit: registered and commented
Linux 4.13.5 includes the fix apparently just have to wait.
Last edited by NickHack997 (2017-10-06 04:03:39)
Offline
#5 2017-10-06 13:13:26
- natervance
- Member
- Registered: 2017-04-20
- Posts: 53
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
NickHack997 wrote:
Linux 4.13.5 includes the fix apparently just have to wait.
Good news! I just grabbed a copy of Linux 4.13.5 from the testing repo (http://mirrors.kernel.org/archlinux/tes … pkg.tar.xz) and installed it with pacman -U. The issues with kworkers timing out have vanished. However, I did start having trouble with libmutter segfaulting when I sleep. But then and again, I upgraded all of gnome this morning. Confounding variables for the win!
Offline
#6 2017-10-06 14:33:11
- NickHack997
- Member
- Registered: 2017-10-06
- Posts: 3
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
Same. Although it's probably a bad decision to partially upgrade my system with the newer kernel.
famous last words.
Offline
#7 2017-10-06 14:34:44
- V1del
- Forum Moderator
- Registered: 2012-10-16
- Posts: 23,249
Re: [SOLVED]Systemctl Suspend fails due to NetworkManager & wpa_supplicant
The kernel is the one package where it is pretty safe to partial update, since it is largely self-contained. Anything else you should at least know what to look out for, which might differ from package to package
Online