syzbot


INFO: task hung in rtnetlink_rcv_msg

Status: auto-closed as invalid on 2021/03/12 19:03
Reported-by: syzbot+14faf578d9d35da85bcd@syzkaller.appspotmail.com
First crash: 1670d, last: 1348d
Similar bugs (8)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: task hung in rtnetlink_rcv_msg 1 374d 374d 0/3 auto-obsoleted due to no activity on 2023/10/22 21:13
linux-4.19 INFO: task hung in rtnetlink_rcv_msg (2) 14 916d 1095d 0/1 auto-closed as invalid on 2022/05/18 11:30
linux-4.19 INFO: task hung in rtnetlink_rcv_msg (3) 8 529d 763d 0/1 upstream: reported on 2022/06/20 23:55
upstream INFO: task hung in rtnetlink_rcv_msg net C inconclusive inconclusive 1970 14d 1977d 27/27 fixed on 2024/07/09 19:14
linux-4.14 INFO: task hung in rtnetlink_rcv_msg 1 509d 509d 0/1 upstream: reported on 2023/03/01 21:15
linux-5.15 INFO: task hung in rtnetlink_rcv_msg (2) 58 19d 176d 0/3 upstream: reported on 2024/01/29 02:32
linux-6.1 INFO: task hung in rtnetlink_rcv_msg (2) 67 13d 178d 0/3 upstream: reported on 2024/01/27 00:38
linux-6.1 INFO: task hung in rtnetlink_rcv_msg 1 299d 299d 0/3 auto-obsoleted due to no activity on 2024/01/09 18:18

Sample crash report:
bridge0: port 2(bridge_slave_1) entered disabled state
bridge0: port 1(bridge_slave_0) entered disabled state
batman_adv: batadv0: Interface deactivated: batadv_slave_0
batman_adv: batadv0: Interface deactivated: batadv_slave_1
INFO: task syz-executor.2:19845 blocked for more than 140 seconds.
      Not tainted 4.19.157-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.2  D28952 19845   8127 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2828 [inline]
 __schedule+0x887/0x2040 kernel/sched/core.c:3517
 schedule+0x8d/0x1b0 kernel/sched/core.c:3561
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
 __mutex_lock_common kernel/locking/mutex.c:1002 [inline]
 __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072
 rtnl_lock net/core/rtnetlink.c:77 [inline]
 rtnetlink_rcv_msg+0x3fe/0xb80 net/core/rtnetlink.c:4775
 netlink_rcv_skb+0x160/0x440 net/netlink/af_netlink.c:2455
 netlink_unicast_kernel net/netlink/af_netlink.c:1318 [inline]
 netlink_unicast+0x4d5/0x690 net/netlink/af_netlink.c:1344
 netlink_sendmsg+0x6bb/0xc40 net/netlink/af_netlink.c:1909
 sock_sendmsg_nosec net/socket.c:622 [inline]
 sock_sendmsg+0xc3/0x120 net/socket.c:632
 ___sys_sendmsg+0x7bb/0x8e0 net/socket.c:2115
 __sys_sendmsg net/socket.c:2153 [inline]
 __do_sys_sendmsg net/socket.c:2162 [inline]
 __se_sys_sendmsg net/socket.c:2160 [inline]
 __x64_sys_sendmsg+0x132/0x220 net/socket.c:2160
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45deb9
Code: f9 00 48 8d 15 88 7e 61 01 48 89 14 24 e8 cf ce fa ff 0f b6 44 24 2f 3c 00 0f 85 10 01 00 00 e8 7d 7e fd ff 48 8d 05 ba 45 50 <00> 48 89 04 24 48 c7 44 24 08 11 00 00 00 e8 a4 87 fd ff 8b 44 24
RSP: 002b:00007fb01aaa9c78 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 000000000002e640 RCX: 000000000045deb9
RDX: 0000000000000000 RSI: 0000000020000140 RDI: 0000000000000004
RBP: 000000000118c158 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118c124
R13: 00007ffdbd35815f R14: 00007fb01aaaa9c0 R15: 000000000118c124
INFO: task syz-executor.4:19872 blocked for more than 140 seconds.
      Not tainted 4.19.157-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D29448 19872   8131 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2828 [inline]
 __schedule+0x887/0x2040 kernel/sched/core.c:3517
 schedule+0x8d/0x1b0 kernel/sched/core.c:3561
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
 __mutex_lock_common kernel/locking/mutex.c:1002 [inline]
 __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072
 sock_do_ioctl+0x1f2/0x2d0 net/socket.c:963
 sock_ioctl+0x2ef/0x5d0 net/socket.c:1074
 vfs_ioctl fs/ioctl.c:46 [inline]
 file_ioctl fs/ioctl.c:501 [inline]
 do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688
 ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705
 __do_sys_ioctl fs/ioctl.c:712 [inline]
 __se_sys_ioctl fs/ioctl.c:710 [inline]
 __x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45deb9
Code: f9 00 48 8d 15 88 7e 61 01 48 89 14 24 e8 cf ce fa ff 0f b6 44 24 2f 3c 00 0f 85 10 01 00 00 e8 7d 7e fd ff 48 8d 05 ba 45 50 <00> 48 89 04 24 48 c7 44 24 08 11 00 00 00 e8 a4 87 fd ff 8b 44 24
RSP: 002b:00007f6c90fd9c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000000013200 RCX: 000000000045deb9
RDX: 0000000000400200 RSI: 0000000000008912 RDI: 0000000000000005
RBP: 000000000118bf60 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118bf2c
R13: 00007ffed192e14f R14: 00007f6c90fda9c0 R15: 000000000118bf2c

Showing all locks held in the system:
3 locks held by kworker/0:1/14:
 #0: 000000006820b8b3 ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126
 #1: 00000000c90e8b12 ((linkwatch_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130
 #2: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: linkwatch_event+0xb/0x60 net/core/link_watch.c:236
1 lock held by khungtaskd/1568:
 #0: 00000000e6660052 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440
1 lock held by in:imklog/7736:
 #0: 00000000483b8003 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
3 locks held by kworker/1:4/9354:
 #0: 0000000050e5a993 ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126
 #1: 000000006742b13d ((addr_chk_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130
 #2: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4475
3 locks held by kworker/0:3/867:
 #0: 000000006820b8b3 ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126
 #1: 000000008863d04b (deferred_process_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130
 #2: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:150
3 locks held by kworker/u4:3/6977:
 #0: 00000000c44c8c81 ((wq_completion)"cfg80211"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126
 #1: 00000000a94d08cb ((work_completion)(&(&rdev->dfs_update_channels_wk)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130
 #2: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: cfg80211_dfs_channels_update_work+0x98/0x59b net/wireless/mlme.c:777
2 locks held by syz-executor.2/19827:
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: rtnl_lock net/core/rtnetlink.c:77 [inline]
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: rtnetlink_rcv_msg+0x3fe/0xb80 net/core/rtnetlink.c:4775
 #1: 00000000d1c1a092 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:297 [inline]
 #1: 00000000d1c1a092 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x4dc/0x6f0 kernel/rcu/tree_exp.h:667
1 lock held by syz-executor.2/19845:
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: rtnl_lock net/core/rtnetlink.c:77 [inline]
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: rtnetlink_rcv_msg+0x3fe/0xb80 net/core/rtnetlink.c:4775
1 lock held by syz-executor.4/19872:
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: sock_do_ioctl+0x1f2/0x2d0 net/socket.c:963
1 lock held by syz-executor.4/19874:
 #0: 000000008c2e89b0 (rtnl_mutex){+.+.}, at: sock_do_ioctl+0x1f2/0x2d0 net/socket.c:963
2 locks held by kworker/1:1/19879:
 #0: 00000000d4a7e6e8 ((wq_completion)"rcu_gp"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126
 #1: 00000000eba0f55e ((work_completion)(&rew.rew_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130

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

NMI backtrace for cpu 1
CPU: 1 PID: 1568 Comm: khungtaskd Not tainted 4.19.157-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x1fc/0x2fe lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1a6/0x1eb lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
 watchdog+0x991/0xe60 kernel/hung_task.c:287
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 10102 Comm: kworker/u4:7 Not tainted 4.19.157-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: phy8 ieee80211_iface_work
RIP: 0010:queued_spin_lock include/asm-generic/qspinlock.h:86 [inline]
RIP: 0010:do_raw_spin_lock+0xd7/0x220 kernel/locking/spinlock_debug.c:113
Code: 55 08 65 8b 05 da 1f b4 7e 39 c2 0f 84 84 00 00 00 be 04 00 00 00 48 89 ef e8 b5 81 4d 00 31 c0 ba 01 00 00 00 f0 0f b1 55 00 <85> c0 75 7b 65 8b 1d ae 1f b4 7e 48 b8 00 00 00 00 00 fc ff df 4c
RSP: 0000:ffff88805f2bf1f8 EFLAGS: 00000046
RAX: 0000000000000000 RBX: 0000000000001f80 RCX: ffffffff814d616b
RDX: 0000000000000001 RSI: 0000000000000004 RDI: ffffffff8d367988
RBP: ffffffff8d367988 R08: 0000000000000001 R09: fffffbfff1a6cf31
R10: ffffffff8d36798b R11: 00000000470a379b R12: ffffffff8d367990
R13: ffffffff8d367998 R14: 1ffff1100be57e4b R15: ffffffff89f85980
FS:  0000000000000000(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000c000228000 CR3: 00000000b2c84000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:117 [inline]
 _raw_spin_lock_irqsave+0x94/0xc0 kernel/locking/spinlock.c:152
 debug_object_activate+0x12f/0x450 lib/debugobjects.c:472
 debug_rcu_head_queue kernel/rcu/rcu.h:193 [inline]
 __call_rcu.constprop.0+0x31/0x7f0 kernel/rcu/tree.c:2977
 cfg80211_bss_update+0x47c/0x2490 net/wireless/scan.c:967
 cfg80211_inform_bss_frame_data+0x69c/0xeb0 net/wireless/scan.c:1283
 ieee80211_bss_info_update+0x42d/0x1800 net/mac80211/scan.c:105
 ieee80211_rx_bss_info net/mac80211/ibss.c:1125 [inline]
 ieee80211_rx_mgmt_probe_beacon+0xb4f/0x15c0 net/mac80211/ibss.c:1607
 ieee80211_ibss_rx_queued_mgmt+0xe27/0x18b0 net/mac80211/ibss.c:1634
 ieee80211_iface_work+0x5c4/0x8a0 net/mac80211/iface.c:1345
 process_one_work+0x864/0x1570 kernel/workqueue.c:2155
 worker_thread+0x64c/0x1130 kernel/workqueue.c:2298
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415

Crashes (11):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2020/11/12 19:02 linux-4.19.y 31acccdc8774 77a55c8e .config console log report info ci2-linux-4-19
2020/08/29 23:50 linux-4.19.y f6d5cb9e2c06 d5a3ae1f .config console log report ci2-linux-4-19
2020/08/23 03:19 linux-4.19.y d18b78abc0c6 1da71ab0 .config console log report ci2-linux-4-19
2020/07/12 07:48 linux-4.19.y dce0f88600e4 115e1930 .config console log report ci2-linux-4-19
2020/04/28 04:50 linux-4.19.y 7edd66cf6167 0ce7569e .config console log report ci2-linux-4-19
2020/03/22 15:07 linux-4.19.y 14cfdbd39e31 78267cec .config console log report ci2-linux-4-19
2020/03/19 07:22 linux-4.19.y 93556fb211fa 2c31c529 .config console log report ci2-linux-4-19
2020/03/10 13:20 linux-4.19.y 7472c4028e23 35f53e45 .config console log report ci2-linux-4-19
2020/02/05 10:27 linux-4.19.y 32ee7492f104 93e5e335 .config console log report ci2-linux-4-19
2020/01/13 21:30 linux-4.19.y dcd888983542 99565c1a .config console log report ci2-linux-4-19
2019/12/26 21:55 linux-4.19.y 672481c2deff be5c2c81 .config console log report ci2-linux-4-19
* Struck through repros no longer work on HEAD.