Hello,
syzbot found the following issue on:
HEAD commit: 3c8c2309 Linux 4.19.190
git tree: linux-4.19.y
console output:
https://syzkaller.appspot.com/x/log.txt?x=1547f653d00000
kernel config:
https://syzkaller.appspot.com/x/.config?x=d3c2572d41264a3d
dashboard link:
https://syzkaller.appspot.com/bug?extid=7b32daef9a262a42e197
Unfortunately, I don't have any reproducer for this issue yet.
IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by:
syzbot+7b32da...@syzkaller.appspotmail.com
ieee802154 phy0 wpan0: encryption failed: -22
ieee802154 phy1 wpan1: encryption failed: -22
Bluetooth: hci4: command 0x0406 tx timeout
ieee802154 phy0 wpan0: encryption failed: -22
ieee802154 phy1 wpan1: encryption failed: -22
INFO: task kworker/u4:3:150 blocked for more than 140 seconds.
Not tainted 4.19.190-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:3 D25808 150 2 0x80000000
Workqueue: netns cleanup_net
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:1005 [inline]
__mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1075
tc_action_net_exit include/net/act_api.h:135 [inline]
tunnel_key_exit_net+0x22/0x360 net/sched/act_tunnel_key.c:591
ops_exit_list+0xf9/0x150 net/core/net_namespace.c:156
cleanup_net+0x3b4/0x8b0 net/core/net_namespace.c:553
process_one_work+0x864/0x1570 kernel/workqueue.c:2152
worker_thread+0x64c/0x1130 kernel/workqueue.c:2295
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task syz-executor.4:20981 blocked for more than 140 seconds.
Not tainted 4.19.190-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4 D26744 20981 19847 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:1005 [inline]
__mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1075
cangw_pernet_exit+0xe/0x20 net/can/gw.c:1029
ops_exit_list+0xa5/0x150 net/core/net_namespace.c:153
setup_net+0x3d1/0x720 net/core/net_namespace.c:332
copy_net_ns+0x1f7/0x340 net/core/net_namespace.c:438
create_new_namespaces+0x3f6/0x7b0 kernel/nsproxy.c:107
copy_namespaces+0x325/0x3c0 kernel/nsproxy.c:165
copy_process.part.0+0x3a59/0x8260 kernel/fork.c:1915
copy_process kernel/fork.c:1709 [inline]
_do_fork+0x22f/0xf30 kernel/fork.c:2218
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4665d9
Code: Bad RIP value.
RSP: 002b:00007f7bb6f24188 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
RAX: ffffffffffffffda RBX: 000000000056c158 RCX: 00000000004665d9
RDX: 9999999999999999 RSI: 0000000000000000 RDI: 0000000060060103
RBP: 00000000004bfcb9 R08: ffffffffffffffff R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c158
R13: 00007fff1c394b7f R14: 00007f7bb6f24300 R15: 0000000000022000
INFO: task syz-executor.4:20983 blocked for more than 140 seconds.
Not tainted 4.19.190-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4 D28184 20983 19847 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
exp_funnel_lock kernel/rcu/tree_exp.h:320 [inline]
_synchronize_rcu_expedited+0x60c/0x6f0 kernel/rcu/tree_exp.h:667
synchronize_rcu+0xc6/0x160 kernel/rcu/tree_plugin.h:818
cfcnfg_remove+0x2b/0x90 net/caif/cfcnfg.c:121
caif_exit_net+0x34d/0x450 net/caif/caif_dev.c:538
ops_exit_list+0xa5/0x150 net/core/net_namespace.c:153
setup_net+0x3d1/0x720 net/core/net_namespace.c:332
copy_net_ns+0x1f7/0x340 net/core/net_namespace.c:438
create_new_namespaces+0x3f6/0x7b0 kernel/nsproxy.c:107
copy_namespaces+0x325/0x3c0 kernel/nsproxy.c:165
copy_process.part.0+0x3a59/0x8260 kernel/fork.c:1915
copy_process kernel/fork.c:1709 [inline]
_do_fork+0x22f/0xf30 kernel/fork.c:2218
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4665d9
Code: Bad RIP value.
RSP: 002b:00007f7bb6f03188 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
RAX: ffffffffffffffda RBX: 000000000056c200 RCX: 00000000004665d9
RDX: 9999999999999999 RSI: 0000000000000000 RDI: 0000000060060103
RBP: 00000000004bfcb9 R08: ffffffffffffffff R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c200
R13: 00007fff1c394b7f R14: 00007f7bb6f03300 R15: 0000000000022000
Showing all locks held in the system:
4 locks held by kworker/u4:3/150:
#0: 000000004cfe8228 ((wq_completion)"%s""netns"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2123
#1: 000000003847a7d1 (net_cleanup_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2127
#2: 00000000fcd77da1 (pernet_ops_rwsem){++++}, at: cleanup_net+0xa8/0x8b0 net/core/net_namespace.c:520
#3: 00000000df916a88 (rtnl_mutex){+.+.}, at: tc_action_net_exit include/net/act_api.h:135 [inline]
#3: 00000000df916a88 (rtnl_mutex){+.+.}, at: tunnel_key_exit_net+0x22/0x360 net/sched/act_tunnel_key.c:591
1 lock held by khungtaskd/1570:
#0: 000000003a62e746 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
3 locks held by kworker/1:2/3687:
#0: 00000000f409c86b ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2123
#1: 000000003e000b85 ((addr_chk_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2127
#2: 00000000df916a88 (rtnl_mutex){+.+.}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4476
3 locks held by kworker/u4:6/9471:
2 locks held by syz-executor.4/20981:
#0: 00000000fcd77da1 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x1d8/0x340 net/core/net_namespace.c:434
#1: 00000000df916a88 (rtnl_mutex){+.+.}, at: cangw_pernet_exit+0xe/0x20 net/can/gw.c:1029
3 locks held by syz-executor.4/20983:
#0: 00000000fcd77da1 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x1d8/0x340 net/core/net_namespace.c:434
#1: 00000000df916a88 (rtnl_mutex){+.+.}, at: caif_exit_net+0x38/0x450 net/caif/caif_dev.c:517
#2: 00000000f24844d8 (&caifn->caifdevs.lock){+.+.}, at: caif_exit_net+0x4f/0x450 net/caif/caif_dev.c:518
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 1570 Comm: khungtaskd Not tainted 4.19.190-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/0x2ef lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 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 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 4690 Comm: systemd-journal Not tainted 4.19.190-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__sanitizer_cov_trace_pc+0x22/0x50 kernel/kcov.c:101
Code: 90 90 90 90 90 90 90 90 48 8b 34 24 65 48 8b 04 25 80 df 01 00 65 8b 15 8c 80 9f 7e 81 e2 00 01 1f 00 75 2b 8b 90 60 13 00 00 <83> fa 02 75 20 48 8b 88 68 13 00 00 8b 80 64 13 00 00 48 8b 11 48
RSP: 0018:ffff8880a12d7ae0 EFLAGS: 00000246
RAX: ffff8880a12ca500 RBX: 0000000000000076 RCX: ffffffff81a5ff57
RDX: 0000000000000000 RSI: ffffffff81a5ff64 RDI: 0000000000000001
RBP: dffffc0000000000 R08: ffffffff8cd35ca0 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000000 R12: ffff8880a2214e60
R13: ffff8880a12d7c38 R14: ffff8880a12d7c38 R15: ffff8880a2214e61
FS: 00007fdca46178c0(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdca1b86000 CR3: 00000000a1b8c000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
may_lookup fs/namei.c:1696 [inline]
link_path_walk.part.0+0x104/0x1230 fs/namei.c:2085
link_path_walk fs/namei.c:2073 [inline]
path_parentat+0x51/0x140 fs/namei.c:2367
filename_parentat+0x198/0x590 fs/namei.c:2389
filename_create+0x9e/0x490 fs/namei.c:3621
user_path_create fs/namei.c:3696 [inline]
do_mkdirat+0xa0/0x2d0 fs/namei.c:3834
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fdca38d2687
Code: 00 b8 ff ff ff ff c3 0f 1f 40 00 48 8b 05 09 d8 2b 00 64 c7 00 5f 00 00 00 b8 ff ff ff ff c3 0f 1f 40 00 b8 53 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d e1 d7 2b 00 f7 d8 64 89 01 48
RSP: 002b:00007fffc59f6ba8 EFLAGS: 00000293 ORIG_RAX: 0000000000000053
RAX: ffffffffffffffda RBX: 00007fffc59f9ac0 RCX: 00007fdca38d2687
RDX: 00007fdca4343a00 RSI: 00000000000001ed RDI: 0000556177a3b8a0
RBP: 00007fffc59f6be0 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000069 R11: 0000000000000293 R12: 0000000000000000
R13: 0000000000000000 R14: 00007fffc59f9ac0 R15: 00007fffc59f70d0
---
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.