INFO: task syz-executor.3:32726 blocked for more than 143 seconds.
Not tainted 6.3.0-rc7-syzkaller-00043-gaf67688dca57 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:20664 pid:32726 ppid:5103 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6760
rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
__down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
inode_lock include/linux/fs.h:758 [inline]
btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
btrfs_sync_file+0x43e/0x10b0 fs/btrfs/file.c:1817
generic_write_sync include/linux/fs.h:2452 [inline]
btrfs_do_write_iter+0xccc/0x1270 fs/btrfs/file.c:1684
do_iter_write+0x6ea/0xc50 fs/read_write.c:861
iter_file_splice_write+0x843/0xfe0 fs/splice.c:778
do_splice_from fs/splice.c:856 [inline]
direct_splice_actor+0xe7/0x1c0 fs/splice.c:1022
splice_direct_to_actor+0x4c4/0xbd0 fs/splice.c:977
do_splice_direct+0x283/0x3d0 fs/splice.c:1065
do_sendfile+0x620/0xff0 fs/read_write.c:1255
__do_sys_sendfile64 fs/read_write.c:1323 [inline]
__se_sys_sendfile64+0x17c/0x1e0 fs/read_write.c:1309
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f771108c169
RSP: 002b:00007f7711d98168 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007f77111abf80 RCX: 00007f771108c169
RDX: 0000000000000000 RSI: 0000000000000009 RDI: 0000000000000008
RBP: 00007f77110e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0001000000201004 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffeb1f633ef R14: 00007f7711d98300 R15: 0000000000022000
INFO: task syz-executor.3:32766 blocked for more than 144 seconds.
Not tainted 6.3.0-rc7-syzkaller-00043-gaf67688dca57 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:23192 pid:32766 ppid:5103 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
wait_on_state fs/btrfs/extent-io-tree.c:707 [inline]
wait_extent_bit+0x50c/0x670 fs/btrfs/extent-io-tree.c:751
lock_extent+0x1ce/0x280 fs/btrfs/extent-io-tree.c:1742
btrfs_page_mkwrite+0x554/0xc90 fs/btrfs/inode.c:8163
do_page_mkwrite+0x1a1/0x600 mm/memory.c:2925
wp_page_shared mm/memory.c:3274 [inline]
do_wp_page+0x501/0x3620 mm/memory.c:3356
handle_pte_fault mm/memory.c:4941 [inline]
__handle_mm_fault mm/memory.c:5065 [inline]
handle_mm_fault+0x23a0/0x51c0 mm/memory.c:5211
do_user_addr_fault arch/x86/mm/fault.c:1407 [inline]
handle_page_fault arch/x86/mm/fault.c:1498 [inline]
exc_page_fault+0x5b1/0x7c0 arch/x86/mm/fault.c:1554
asm_exc_page_fault+0x26/0x30 arch/x86/include/asm/idtentry.h:570
RIP: 0010:copy_user_short_string+0xd/0x40 arch/x86/lib/copy_user_64.S:233
Code: 74 0a 89 d1 f3 a4 89 c8 0f 01 ca c3 89 d0 0f 01 ca c3 01 ca eb e7 0f 1f 80 00 00 00 00 89 d1 83 e2 07 c1 e9 03 74 12 4c 8b 06 <4c> 89 07 48 8d 76 08 48 8d 7f 08 ff c9 75 ee 21 d2 74 10 89 d1 8a
RSP: 0018:ffffc9000314f4d0 EFLAGS: 00050202
RAX: ffffffff84303c01 RBX: 00007fffffffefc8 RCX: 0000000000000007
RDX: 0000000000000000 RSI: ffffc9000314f580 RDI: 00000000200013e0
RBP: ffffc9000314f628 R08: 0000000000000000 R09: fffff52000629eb7
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000038
R13: ffffc9000314f580 R14: 00000000200013e0 R15: ffffc9000314f580
copy_user_generic arch/x86/include/asm/uaccess_64.h:37 [inline]
raw_copy_to_user arch/x86/include/asm/uaccess_64.h:58 [inline]
_copy_to_user+0xed/0x130 lib/usercopy.c:41
copy_to_user include/linux/uaccess.h:169 [inline]
fiemap_fill_next_extent+0x235/0x410 fs/ioctl.c:144
emit_fiemap_extent+0x242/0x3f0 fs/btrfs/extent_io.c:3002
extent_fiemap+0xfd1/0x2150 fs/btrfs/extent_io.c:3492
btrfs_fiemap+0x178/0x1e0 fs/btrfs/inode.c:7835
ioctl_fiemap fs/ioctl.c:219 [inline]
do_vfs_ioctl+0x19ba/0x2b10 fs/ioctl.c:810
__do_sys_ioctl fs/ioctl.c:868 [inline]
__se_sys_ioctl+0x81/0x160 fs/ioctl.c:856
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f771108c169
RSP: 002b:00007f7711d77168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f77111ac050 RCX: 00007f771108c169
RDX: 00000000200013c0 RSI: 00000000c020660b RDI: 0000000000000004
RBP: 00007f77110e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffeb1f633ef R14: 00007f7711d77300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8cf25570 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8cf25d70 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by khungtaskd/28:
#0: ffffffff8cf253a0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by getty/4742:
#0: ffff88814a0eb098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc900015902f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6ab/0x1db0 drivers/tty/n_tty.c:2177
2 locks held by kworker/u4:3/18679:
#0: ffff888012479138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffff88801246adb0 (&mm->cid_lock){....}-{2:2}, at: mm_cid_get kernel/sched/sched.h:3280 [inline]
#1: ffff88801246adb0 (&mm->cid_lock){....}-{2:2}, at: switch_mm_cid kernel/sched/sched.h:3302 [inline]
#1: ffff88801246adb0 (&mm->cid_lock){....}-{2:2}, at: prepare_task_switch kernel/sched/core.c:5117 [inline]
#1: ffff88801246adb0 (&mm->cid_lock){....}-{2:2}, at: context_switch kernel/sched/core.c:5258 [inline]
#1: ffff88801246adb0 (&mm->cid_lock){....}-{2:2}, at: __schedule+0x12e4/0x4630 kernel/sched/core.c:6625
2 locks held by kworker/u4:8/3738:
#0: ffff888012479138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffff8880241f26b0 (&p->pi_lock){-.-.}-{2:2}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
2 locks held by syz-executor.3/32726:
#0: ffff88803485e460 (sb_writers#14){.+.+}-{0:0}, at: do_sendfile+0x5fb/0xff0 fs/read_write.c:1254
#1: ffff888084503450 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: inode_lock include/linux/fs.h:758 [inline]
#1: ffff888084503450 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
4 locks held by syz-executor.3/32766:
#0: ffff888084503450 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:768 [inline]
#0: ffff888084503450 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: btrfs_inode_lock+0x60/0xd0 fs/btrfs/inode.c:169
#1: ffff88802bad2e98 (&mm->mmap_lock){++++}-{3:3}, at: mmap_read_trylock include/linux/mmap_lock.h:136 [inline]
#1: ffff88802bad2e98 (&mm->mmap_lock){++++}-{3:3}, at: do_user_addr_fault arch/x86/mm/fault.c:1348 [inline]
#1: ffff88802bad2e98 (&mm->mmap_lock){++++}-{3:3}, at: handle_page_fault arch/x86/mm/fault.c:1498 [inline]
#1: ffff88802bad2e98 (&mm->mmap_lock){++++}-{3:3}, at: exc_page_fault+0x18e/0x7c0 arch/x86/mm/fault.c:1554
#2: ffff88803485e558 (sb_pagefaults){.+.+}-{0:0}, at: do_page_mkwrite+0x1a1/0x600 mm/memory.c:2925
#3: ffff8880845032d8 (&ei->i_mmap_lock){++++}-{3:3}, at: btrfs_page_mkwrite+0x425/0xc90 fs/btrfs/inode.c:8152
2 locks held by syz-executor.2/2275:
#0: ffff8880b993be98 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:539
#1: ffff888075cbf5b0 (&mm->cid_lock){....}-{2:2}, at: mm_cid_get kernel/sched/sched.h:3280 [inline]
#1: ffff888075cbf5b0 (&mm->cid_lock){....}-{2:2}, at: switch_mm_cid kernel/sched/sched.h:3302 [inline]
#1: ffff888075cbf5b0 (&mm->cid_lock){....}-{2:2}, at: prepare_task_switch kernel/sched/core.c:5117 [inline]
#1: ffff888075cbf5b0 (&mm->cid_lock){....}-{2:2}, at: context_switch kernel/sched/core.c:5258 [inline]
#1: ffff888075cbf5b0 (&mm->cid_lock){....}-{2:2}, at: __schedule+0x12e4/0x4630 kernel/sched/core.c:6625
2 locks held by syz-executor.4/2280:
2 locks held by syz-executor.0/2284:
2 locks held by syz-executor.3/2290:
2 locks held by udevadm/2286:
1 lock held by syz-executor.1/2292:
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.3.0-rc7-syzkaller-00043-gaf67688dca57 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/30/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e7/0x2d0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x498/0x4d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x187/0x300 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
watchdog+0xec2/0xf00 kernel/hung_task.c:379
kthread+0x270/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 2290 Comm: syz-executor.3 Not tainted 6.3.0-rc7-syzkaller-00043-gaf67688dca57 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/30/2023
RIP: 0010:ktime_get_update_offsets_now+0x4e/0x420
Code: be 00 00 00 00 00 fc ff df e8 6e f4 0f 00 4c 89 64 24 20 e8 64 9d ff ff 8b 1d 5e 5a 79 0b 89 de 83 e6 01 31 ff e8 02 f8 0f 00 <89> 5c 24 0c 89 d8 83 e0 01 75 07 e8 42 f4 0f 00 eb 1c f3 90 8b 05
RSP: 0000:ffffc90015c17da0 EFLAGS: 00000046
RAX: 0000000080010001 RBX: 00000000000915e6 RCX: ffff8880272057c0
RDX: ffff8880272057c0 RSI: 0000000000000000 RDI: 0000000000000000
RBP: ffff8880b992b750 R08: ffffffff817a826e R09: fffffbfff1ca6946
R10: 0000000000000000 R11: dffffc0000000001 R12: ffff8880b992b868
R13: dffffc0000000000 R14: dffffc0000000000 R15: ffff8880b99281d8
FS: 00007f740af30700(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f7401795000 CR3: 000000002ad97000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
hrtimer_update_base kernel/time/hrtimer.c:631 [inline]
hrtimer_interrupt+0x133/0x980 kernel/time/hrtimer.c:1793
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1096 [inline]
__sysvec_apic_timer_interrupt+0x13f/0x480 arch/x86/kernel/apic/apic.c:1113
sysvec_apic_timer_interrupt+0x42/0xb0 arch/x86/kernel/apic/apic.c:1107
asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0033:0x7f740a22923c
Code: 01 c2 49 3b 55 08 77 56 8d 55 ff 85 ed 74 35 0f 1f 80 00 00 00 00 48 39 c1 77 1c 49 8b 75 00 49 89 c1 49 29 c9 46 0f b6 0c 0e <45> 84 c9 74 08 44 88 0c 06 49 8b 45 10 48 83 c0 01 49 89 45 10 83
RSP: 002b:00007f740af2f600 EFLAGS: 00000202
RAX: 0000000000d969e4 RBX: 00007f740af2f660 RCX: 0000000000000001
RDX: 0000000000000011 RSI: 00007f74009ff000 RDI: 00007f740af2f700
RBP: 0000000000000102 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 00007f740af2f670 R12: 00007f740af2f670
R13: 00007f740af2f700 R14: 0000000000000001 R15: 0000000000000000