syzbot


INFO: task hung in cleanup_net (3)

Status: auto-closed as invalid on 2019/10/25 14:21
Reported-by: syzbot+@syzkaller.appspotmail.com
First crash: 1143d, last: 1143d
similar bugs (10):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in cleanup_net (2) 2 1208d 1209d 0/23 closed as invalid on 2019/05/08 13:05
android-44 INFO: task hung in cleanup_net 10 1162d 1204d 0/2 auto-closed as invalid on 2019/10/25 08:38
upstream INFO: task hung in cleanup_net 1 1713d 1701d 3/23 fixed on 2018/01/03 02:35
linux-4.19 INFO: task hung in cleanup_net 1 827d 827d 0/1 auto-closed as invalid on 2020/09/08 00:00
linux-4.14 INFO: task hung in cleanup_net C inconclusive 23 215d 1221d 0/1 upstream: reported C repro on 2019/04/13 10:16
android-49 INFO: task hung in cleanup_net 4 1212d 1220d 0/3 auto-closed as invalid on 2019/10/18 21:44
upstream INFO: task hung in cleanup_net (4) 2 727d 731d 0/23 auto-closed as invalid on 2020/11/17 15:39
android-414 INFO: task hung in cleanup_net C 45 1081d 1223d 0/1 public: reported C repro on 2019/04/11 00:00
android-49 INFO: task hung in cleanup_net (2) 1 996d 996d 0/3 auto-closed as invalid on 2020/03/23 02:35
upstream INFO: task hung in cleanup_net (5) 3 453d 499d 0/23 auto-closed as invalid on 2021/09/03 11:33

Sample crash report:
INFO: task kworker/u4:0:7 blocked for more than 143 seconds.
      Not tainted 5.2.0-rc6-next-20190628 #25
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:0    D23800     7      2 0x80004000
Workqueue: netns cleanup_net
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_read_slowpath+0x4cc/0xf90 kernel/locking/rwsem.c:1079
 __down_read kernel/locking/rwsem.c:1304 [inline]
 down_read+0x1f4/0x3f0 kernel/locking/rwsem.c:1447
 cleanup_net+0xae/0xa70 net/core/net_namespace.c:556
 process_one_work+0x9af/0x1740 kernel/workqueue.c:2269
 worker_thread+0x98/0xe40 kernel/workqueue.c:2415
 kthread+0x361/0x430 kernel/kthread.c:255
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:353
INFO: task syz-executor.4:20335 can't die for more than 143 seconds.
syz-executor.4  D28160 20335   8798 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 unregister_netdevice_notifier+0x7e/0x390 net/core/dev.c:1713
 raw_release+0x57/0x700 net/can/raw.c:358
 __sock_release+0xce/0x2a0 net/socket.c:601
 sock_close+0x1b/0x30 net/socket.c:1273
 __fput+0x2ff/0x890 fs/file_table.c:280
 ____fput+0x16/0x20 fs/file_table.c:313
 task_work_run+0x145/0x1c0 kernel/task_work.c:113
 tracehook_notify_resume include/linux/tracehook.h:188 [inline]
 exit_to_usermode_loop+0x280/0x2d0 arch/x86/entry/common.c:163
 prepare_exit_to_usermode arch/x86/entry/common.c:194 [inline]
 syscall_return_slowpath arch/x86/entry/common.c:274 [inline]
 do_syscall_64+0x5a9/0x6a0 arch/x86/entry/common.c:299
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x413201
Code: Bad RIP value.
RSP: 002b:00007fff52cff660 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000413201
RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000005
RBP: 0000000000000000 R08: ffffffffffffffff R09: ffffffffffffffff
R10: 00007fff52cff740 R11: 0000000000000293 R12: 0000000000762800
R13: 00000000002178b3 R14: 00000000002178e0 R15: ffffffffffffffff
INFO: task syz-executor.4:20335 blocked for more than 143 seconds.
      Not tainted 5.2.0-rc6-next-20190628 #25
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D28160 20335   8798 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 unregister_netdevice_notifier+0x7e/0x390 net/core/dev.c:1713
 raw_release+0x57/0x700 net/can/raw.c:358
 __sock_release+0xce/0x2a0 net/socket.c:601
 sock_close+0x1b/0x30 net/socket.c:1273
 __fput+0x2ff/0x890 fs/file_table.c:280
 ____fput+0x16/0x20 fs/file_table.c:313
 task_work_run+0x145/0x1c0 kernel/task_work.c:113
 tracehook_notify_resume include/linux/tracehook.h:188 [inline]
 exit_to_usermode_loop+0x280/0x2d0 arch/x86/entry/common.c:163
 prepare_exit_to_usermode arch/x86/entry/common.c:194 [inline]
 syscall_return_slowpath arch/x86/entry/common.c:274 [inline]
 do_syscall_64+0x5a9/0x6a0 arch/x86/entry/common.c:299
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x413201
Code: Bad RIP value.
RSP: 002b:00007fff52cff660 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000413201
RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000005
RBP: 0000000000000000 R08: ffffffffffffffff R09: ffffffffffffffff
R10: 00007fff52cff740 R11: 0000000000000293 R12: 0000000000762800
R13: 00000000002178b3 R14: 00000000002178e0 R15: ffffffffffffffff
INFO: task syz-executor.0:20433 can't die for more than 144 seconds.
syz-executor.0  D29712 20433  20411 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644
 raw_init+0x299/0x340 net/can/raw.c:343
 can_create+0x288/0x4b0 net/can/af_can.c:178
 __sock_create+0x3d8/0x730 net/socket.c:1424
 sock_create net/socket.c:1475 [inline]
 __sys_socket+0x103/0x220 net/socket.c:1517
 __do_sys_socket net/socket.c:1526 [inline]
 __se_sys_socket net/socket.c:1524 [inline]
 __x64_sys_socket+0x73/0xb0 net/socket.c:1524
 do_syscall_64+0xfd/0x6a0 arch/x86/entry/common.c:296
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x459519
Code: Bad RIP value.
RSP: 002b:00007f61da9e6c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000029
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000459519
RDX: 0000000000000001 RSI: 0000000000000003 RDI: 000000000000001d
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f61da9e76d4
R13: 00000000004c7f4d R14: 00000000004de738 R15: 00000000ffffffff
INFO: task syz-executor.0:20433 blocked for more than 144 seconds.
      Not tainted 5.2.0-rc6-next-20190628 #25
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0  D29712 20433  20411 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644
 raw_init+0x299/0x340 net/can/raw.c:343
 can_create+0x288/0x4b0 net/can/af_can.c:178
 __sock_create+0x3d8/0x730 net/socket.c:1424
 sock_create net/socket.c:1475 [inline]
 __sys_socket+0x103/0x220 net/socket.c:1517
 __do_sys_socket net/socket.c:1526 [inline]
 __se_sys_socket net/socket.c:1524 [inline]
 __x64_sys_socket+0x73/0xb0 net/socket.c:1524
 do_syscall_64+0xfd/0x6a0 arch/x86/entry/common.c:296
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x459519
Code: Bad RIP value.
RSP: 002b:00007f61da9e6c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000029
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000459519
RDX: 0000000000000001 RSI: 0000000000000003 RDI: 000000000000001d
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f61da9e76d4
R13: 00000000004c7f4d R14: 00000000004de738 R15: 00000000ffffffff
INFO: task syz-executor.0:20537 can't die for more than 144 seconds.
syz-executor.0  D28144 20537  20411 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644
 raw_init+0x299/0x340 net/can/raw.c:343
 can_create+0x288/0x4b0 net/can/af_can.c:178
 __sock_create+0x3d8/0x730 net/socket.c:1424
 sock_create net/socket.c:1475 [inline]
 __sys_socket+0x103/0x220 net/socket.c:1517
 __do_sys_socket net/socket.c:1526 [inline]
 __se_sys_socket net/socket.c:1524 [inline]
 __x64_sys_socket+0x73/0xb0 net/socket.c:1524
 do_syscall_64+0xfd/0x6a0 arch/x86/entry/common.c:296
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x459519
Code: Bad RIP value.
RSP: 002b:00007f61da9a4c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000029
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000459519
RDX: 0000000000000001 RSI: 0000000000000003 RDI: 000000000000001d
RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f61da9a56d4
R13: 00000000004c7f4d R14: 00000000004de738 R15: 00000000ffffffff
INFO: task syz-executor.0:20537 blocked for more than 144 seconds.
      Not tainted 5.2.0-rc6-next-20190628 #25
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0  D28144 20537  20411 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:3252 [inline]
 __schedule+0x755/0x1580 kernel/sched/core.c:3878
 schedule+0xa8/0x270 kernel/sched/core.c:3942
 rwsem_down_write_slowpath+0x708/0xf60 kernel/locking/rwsem.c:1198
 __down_write kernel/locking/rwsem.c:1349 [inline]
 down_write+0x13c/0x150 kernel/locking/rwsem.c:1485
 register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644
 raw_init+0x299/0x340 net/can/raw.c:343
 can_create+0x288/0x4b0 net/can/af_can.c:178
 __sock_create+0x3d8/0x730 net/socket.c:1424
 sock_create net/socket.c:1475 [inline]
 __sys_socket+0x103/0x220 net/socket.c:1517
 __do_sys_socket net/socket.c:1526 [inline]
 __se_sys_socket net/socket.c:1524 [inline]
 __x64_sys_socket+0x73/0xb0 net/socket.c:1524
 do_syscall_64+0xfd/0x6a0 arch/x86/entry/common.c:296
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x459519
Code: Bad RIP value.
RSP: 002b:00007f61da9a4c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000029
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000459519
RDX: 0000000000000001 RSI: 0000000000000003 RDI: 000000000000001d
RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f61da9a56d4
R13: 00000000004c7f4d R14: 00000000004de738 R15: 00000000ffffffff

Showing all locks held in the system:
3 locks held by kworker/u4:0/7:
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: __write_once_size include/linux/compiler.h:221 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: set_work_data kernel/workqueue.c:620 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:647 [inline]
 #0: 0000000000f45c2c ((wq_completion)netns){+.+.}, at: process_one_work+0x88b/0x1740 kernel/workqueue.c:2240
 #1: 00000000767976ee (net_cleanup_work){+.+.}, at: process_one_work+0x8c1/0x1740 kernel/workqueue.c:2244
 #2: 00000000e99a0437 (pernet_ops_rwsem){++++}, at: cleanup_net+0xae/0xa70 net/core/net_namespace.c:556
1 lock held by khungtaskd/1047:
 #0: 00000000f1efa90c (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:5257
1 lock held by rsyslogd/8655:
 #0: 000000009943055d (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801
2 locks held by getty/8745:
 #0: 00000000a3b9a358 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 000000001a3da1b2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8746:
 #0: 00000000bdcba600 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 000000002a84d834 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8747:
 #0: 00000000f5eac6b7 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 000000001d8e01fe (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8748:
 #0: 00000000e29af52a (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 00000000256cdfd9 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8749:
 #0: 0000000085e90189 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 000000008c638b8b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8750:
 #0: 00000000f5dd10b5 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 00000000c7f9457c (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by getty/8751:
 #0: 0000000092b3c9d4 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341
 #1: 00000000fe191325 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156
2 locks held by syz-executor.0/19724:
2 locks held by syz-executor.4/20335:
 #0: 00000000eb68e917 (&sb->s_type->i_mutex_key#11){+.+.}, at: inode_lock include/linux/fs.h:778 [inline]
 #0: 00000000eb68e917 (&sb->s_type->i_mutex_key#11){+.+.}, at: __sock_release+0x89/0x2a0 net/socket.c:600
 #1: 00000000e99a0437 (pernet_ops_rwsem){++++}, at: unregister_netdevice_notifier+0x7e/0x390 net/core/dev.c:1713
1 lock held by syz-executor.0/20433:
 #0: 00000000e99a0437 (pernet_ops_rwsem){++++}, at: register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644
1 lock held by syz-executor.0/20537:
 #0: 00000000e99a0437 (pernet_ops_rwsem){++++}, at: register_netdevice_notifier+0x7e/0x630 net/core/dev.c:1644

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

NMI backtrace for cpu 1
CPU: 1 PID: 1047 Comm: khungtaskd Not tainted 5.2.0-rc6-next-20190628 #25
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+0x172/0x1f0 lib/dump_stack.c:113
 nmi_cpu_backtrace.cold+0x70/0xb2 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x23b/0x28b lib/nmi_backtrace.c:62
 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:249 [inline]
 watchdog+0xc54/0x1320 kernel/hung_task.c:333
 kthread+0x361/0x430 kernel/kthread.c:255
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:353
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0xe/0x10 arch/x86/include/asm/irqflags.h:60

Crashes (1):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-linux-next-kasan-gce-root 2019/06/30 14:49 linux-next 48568d8c7f47 7509bf36 .config log report