syzbot


INFO: task hung in disconnect_work

Status: upstream: reported C repro on 2020/10/28 14:37
Reported-by: syzbot+2f6071c19889d0429f6a@syzkaller.appspotmail.com
First crash: 1335d, last: 940d
Fix bisection the fix commit could be any of (bisect log):
  5b7a52cd2eef Linux 4.14.202
  8ee0807eedf3 Linux 4.14.259
  
Similar bugs (3)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 INFO: task hung in disconnect_work (2) 1 640d 640d 0/1 auto-obsoleted due to no activity on 2023/01/21 15:24
linux-4.19 INFO: task hung in disconnect_work 1 1208d 1208d 0/1 auto-closed as invalid on 2021/07/02 18:09
upstream INFO: task hung in disconnect_work wireless C inconclusive done 3 949d 1224d 20/27 fixed on 2022/03/08 16:11
Last patch testing requests (2)
Created Duration User Patch Repo Result
2023/02/08 16:32 13m retest repro linux-4.14.y report log
2022/09/18 08:29 14m retest repro linux-4.14.y report log
Fix bisection attempts (14)
Created Duration User Patch Repo Result
2021/12/27 14:41 32m bisect fix linux-4.14.y job log (2)
2021/11/27 13:34 31m bisect fix linux-4.14.y job log (0) log
2021/10/28 13:06 26m bisect fix linux-4.14.y job log (0) log
2021/09/24 00:52 30m bisect fix linux-4.14.y job log (0) log
2021/08/24 21:32 28m bisect fix linux-4.14.y job log (0) log
2021/07/25 20:51 29m bisect fix linux-4.14.y job log (0) log
2021/06/25 20:09 24m bisect fix linux-4.14.y job log (0) log
2021/05/26 19:40 28m bisect fix linux-4.14.y job log (0) log
2021/04/26 19:03 36m bisect fix linux-4.14.y job log (0) log
2021/03/27 17:01 28m bisect fix linux-4.14.y job log (0) log
2021/02/25 16:31 29m bisect fix linux-4.14.y job log (0) log
2021/01/26 16:00 30m bisect fix linux-4.14.y job log (0) log
2020/12/27 15:23 34m bisect fix linux-4.14.y job log (0) log
2020/11/27 14:45 30m bisect fix linux-4.14.y job log (0) log

Sample crash report:
IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50
wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50
IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
INFO: task kworker/0:2:4654 blocked for more than 140 seconds.
      Not tainted 4.14.202-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/0:2     D27504  4654      2 0x80000000
Workqueue: events disconnect_work
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3384
 schedule+0x8d/0x1b0 kernel/sched/core.c:3428
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486
 __mutex_lock_common kernel/locking/mutex.c:833 [inline]
 __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893
 disconnect_work+0x14/0x1d0 net/wireless/sme.c:664
 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/0:0:8057 blocked for more than 140 seconds.
      Not tainted 4.14.202-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/0:0     D30760  8057      2 0x80000000
Workqueue: ipv6_addrconf addrconf_dad_work
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3384
 schedule+0x8d/0x1b0 kernel/sched/core.c:3428
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486
 __mutex_lock_common kernel/locking/mutex.c:833 [inline]
 __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893
 addrconf_dad_work+0x89/0xef0 net/ipv6/addrconf.c:3917
 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/0:3:8058 blocked for more than 140 seconds.
      Not tainted 4.14.202-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/0:3     D30880  8058      2 0x80000000
Workqueue: events linkwatch_event
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3384
 schedule+0x8d/0x1b0 kernel/sched/core.c:3428
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486
 __mutex_lock_common kernel/locking/mutex.c:833 [inline]
 __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893
 linkwatch_event+0xa/0x50 net/core/link_watch.c:236
 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404

Showing all locks held in the system:
1 lock held by khungtaskd/1529:
 #0:  (tasklist_lock){.+.+}, at: [<ffffffff81430a04>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548
3 locks held by kworker/0:2/4654:
 #0:  ("events"){+.+.}, at: [<ffffffff813733a0>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  (cfg80211_disconnect_work){+.+.}, at: [<ffffffff813733d6>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
 #2:  (rtnl_mutex){+.+.}, at: [<ffffffff86c3b8f4>] disconnect_work+0x14/0x1d0 net/wireless/sme.c:664
3 locks held by kworker/0:0/8057:
 #0:  ("%s"("ipv6_addrconf")){+.+.}, at: [<ffffffff813733a0>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&(&ifa->dad_work)->work)){+.+.}, at: [<ffffffff813733d6>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
 #2:  (rtnl_mutex){+.+.}, at: [<ffffffff86520479>] addrconf_dad_work+0x89/0xef0 net/ipv6/addrconf.c:3917
3 locks held by kworker/0:3/8058:
 #0:  ("events"){+.+.}, at: [<ffffffff813733a0>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((linkwatch_work).work){+.+.}, at: [<ffffffff813733d6>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
 #2:  (rtnl_mutex){+.+.}, at: [<ffffffff85e3714a>] linkwatch_event+0xa/0x50 net/core/link_watch.c:236

=============================================

NMI backtrace for cpu 0
CPU: 0 PID: 1529 Comm: khungtaskd Not tainted 4.14.202-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x1b2/0x283 lib/dump_stack.c:58
 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x13a/0x17f lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
 watchdog+0x5b9/0xb40 kernel/hung_task.c:274
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Sending NMI from CPU 0 to CPUs 1:
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.057 msecs
NMI backtrace for cpu 1
CPU: 1 PID: 8056 Comm: syz-executor757 Not tainted 4.14.202-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff88809482a500 task.stack: ffff8880953d0000
RIP: 0010:get_current arch/x86/include/asm/current.h:15 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x50 kernel/kcov.c:60
RSP: 0018:ffff8880953d7480 EFLAGS: 00000202
RAX: ffff888095fedee0 RBX: ffff888095fed700 RCX: 1ffffffff1279ee0
RDX: 0000000000000000 RSI: 00000000ffffffff RDI: ffff888095fedee0
RBP: ffff8880abd1df20 R08: 0000000000000000 R09: 0000000000040596
R10: ffff88809482ae00 R11: ffff88809482a500 R12: 0000000000000000
R13: dffffc0000000000 R14: ffff8880abd1df00 R15: 0000000000000000
FS:  000000000267c880(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055b357c357a8 CR3: 00000000aaf14000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 ieee80211_chanctx_radar_detect+0x1b6/0x350 net/mac80211/util.c:3349
 ieee80211_check_combinations+0x31d/0x6e0 net/mac80211/util.c:3408
 ieee80211_check_concurrent_iface+0x3a6/0x530 net/mac80211/iface.c:311
 ieee80211_runtime_change_iftype net/mac80211/iface.c:1558 [inline]
 ieee80211_if_change_type+0x212/0x470 net/mac80211/iface.c:1596
 ieee80211_change_iface+0x26/0x1e0 net/mac80211/cfg.c:156
 rdev_change_virtual_intf net/wireless/rdev-ops.h:69 [inline]
 cfg80211_change_iface+0x246/0x13d0 net/wireless/util.c:1048
 nl80211_set_interface+0x588/0x760 net/wireless/nl80211.c:2926
 genl_family_rcv_msg+0x572/0xb20 net/netlink/genetlink.c:600
 genl_rcv_msg+0xaf/0x140 net/netlink/genetlink.c:625
 netlink_rcv_skb+0x125/0x390 net/netlink/af_netlink.c:2433
 genl_rcv+0x24/0x40 net/netlink/genetlink.c:636
 netlink_unicast_kernel net/netlink/af_netlink.c:1287 [inline]
 netlink_unicast+0x437/0x610 net/netlink/af_netlink.c:1313
 netlink_sendmsg+0x62e/0xb80 net/netlink/af_netlink.c:1878
 sock_sendmsg_nosec net/socket.c:646 [inline]
 sock_sendmsg+0xb5/0x100 net/socket.c:656
 ___sys_sendmsg+0x6c8/0x800 net/socket.c:2062
 __sys_sendmsg+0xa3/0x120 net/socket.c:2096
 SYSC_sendmsg net/socket.c:2107 [inline]
 SyS_sendmsg+0x27/0x40 net/socket.c:2103
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x442209
RSP: 002b:00007ffdf31effb8 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000000000442209
RDX: 0000000000000000 RSI: 0000000020000340 RDI: 0000000000000003
RBP: 000000306e616c77 R08: 0000001300000000 R09: 0000001300000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00000000000f553f
R13: 0000000000000000 R14: 000000000000000c R15: 0000000000000004
Code: 00 48 c7 c7 20 66 8d 87 4c 89 3d bc 7c 94 0a 41 bd f4 ff ff ff e8 b2 8c ee ff 48 c7 05 a6 7c 94 0a 00 00 00 00 e9 c6 ed ff ff 90 <65> 48 8b 04 25 80 df 01 00 48 85 c0 74 1a 65 8b 15 5b a2 aa 7e 

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2020/10/28 14:36 linux-4.14.y 5b7a52cd2eef 96e03c1c .config console log report syz C ci2-linux-4-14
* Struck through repros no longer work on HEAD.