INFO: task hung in disconnect_work

7 views
Skip to first unread message

syzbot

unread,
Oct 28, 2020, 10:37:28 AM10/28/20
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: 5b7a52cd Linux 4.14.202
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=16d5c6f2500000
kernel config: https://syzkaller.appspot.com/x/.config?x=fa386e02ca459165
dashboard link: https://syzkaller.appspot.com/bug?extid=2f6071c19889d0429f6a
compiler: gcc (GCC) 10.1.0-syz 20200507
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=1261fae4500000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=16d7e670500000

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+2f6071...@syzkaller.appspotmail.com

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


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.
syzbot can test patches for this issue, for details see:
https://goo.gl/tpsmEJ#testing-patches
Reply all
Reply to author
Forward
0 new messages