INFO: task kworker/u4:13:5310 blocked for more than 143 seconds.
Not tainted 5.15.168-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u4:13 state:D stack:24216 pid: 5310 ppid: 2 flags:0x00004000
Workqueue: btrfs-endio-write btrfs_work_helper
Call Trace:
context_switch kernel/sched/core.c:5027 [inline]
__schedule+0x12c4/0x45b0 kernel/sched/core.c:6373
schedule+0x11b/0x1f0 kernel/sched/core.c:6456
wait_on_state fs/btrfs/extent_io.c:868 [inline]
wait_extent_bit+0x3f9/0x530 fs/btrfs/extent_io.c:906
lock_extent_bits+0x10d/0x1e0 fs/btrfs/extent_io.c:1469
btrfs_finish_ordered_io+0x615/0x1db0 fs/btrfs/inode.c:3108
btrfs_work_helper+0x36e/0xbc0 fs/btrfs/async-thread.c:325
process_one_work+0x8a1/0x10c0 kernel/workqueue.c:2310
worker_thread+0xaca/0x1280 kernel/workqueue.c:2457
kthread+0x3f6/0x4f0 kernel/kthread.c:334
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287
INFO: task syz.1.454:5711 blocked for more than 143 seconds.
Not tainted 5.15.168-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.1.454 state:D stack:23264 pid: 5711 ppid: 4644 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5027 [inline]
__schedule+0x12c4/0x45b0 kernel/sched/core.c:6373
schedule+0x11b/0x1f0 kernel/sched/core.c:6456
wait_on_state fs/btrfs/extent_io.c:868 [inline]
wait_extent_bit+0x3f9/0x530 fs/btrfs/extent_io.c:906
lock_extent_bits+0x10d/0x1e0 fs/btrfs/extent_io.c:1469
btrfs_page_mkwrite+0x5f2/0xd60 fs/btrfs/inode.c:8961
do_page_mkwrite+0x1a9/0x440 mm/memory.c:2909
wp_page_shared+0x179/0x690 mm/memory.c:3246
handle_pte_fault mm/memory.c:4655 [inline]
__handle_mm_fault mm/memory.c:4772 [inline]
handle_mm_fault+0x2a3d/0x5960 mm/memory.c:4870
do_user_addr_fault arch/x86/mm/fault.c:1357 [inline]
handle_page_fault arch/x86/mm/fault.c:1445 [inline]
exc_page_fault+0x271/0x700 arch/x86/mm/fault.c:1501
asm_exc_page_fault+0x22/0x30 arch/x86/include/asm/idtentry.h:606
RIP: 0010:copy_user_generic_unrolled+0x89/0xc0 arch/x86/lib/copy_user_64.S:92
Code: 38 4c 89 47 20 4c 89 4f 28 4c 89 57 30 4c 89 5f 38 48 8d 76 40 48 8d 7f 40 ff c9 75 b6 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:ffffc90003227668 EFLAGS: 00050202
RAX: ffffffff84099701 RBX: 0000000020000518 RCX: 0000000000000007
RDX: 0000000000000000 RSI: ffffc90003227720 RDI: 00000000200004e0
RBP: ffffc900032277d0 R08: 0000000000000000 R09: fffff52000644eeb
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000038
R13: 00007ffffffff000 R14: ffffc90003227720 R15: 00000000200004e0
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+0xef/0x130 lib/usercopy.c:40
copy_to_user include/linux/uaccess.h:200 [inline]
fiemap_fill_next_extent+0x231/0x410 fs/ioctl.c:144
emit_fiemap_extent fs/btrfs/extent_io.c:5448 [inline]
extent_fiemap+0x1185/0x1650 fs/btrfs/extent_io.c:5687
btrfs_fiemap+0x121/0x160 fs/btrfs/inode.c:8584
ioctl_fiemap fs/ioctl.c:219 [inline]
do_vfs_ioctl+0x1934/0x2b70 fs/ioctl.c:814
__do_sys_ioctl fs/ioctl.c:872 [inline]
__se_sys_ioctl+0x81/0x160 fs/ioctl.c:860
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x66/0xd0
RIP: 0033:0x7f93e27faff9
RSP: 002b:00007f93e0c73038 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f93e29b2f80 RCX: 00007f93e27faff9
RDX: 00000000200004c0 RSI: 00000000c020660b RDI: 0000000000000004
RBP: 00007f93e286d296 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f93e29b2f80 R15: 00007ffcb08bd848
Showing all locks held in the system:
1 lock held by khungtaskd/27:
#0: ffffffff8c91fc20 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
4 locks held by kworker/u4:2/154:
2 locks held by getty/3325:
#0: ffff888029a05098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:252
#1: ffffc9000208e2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6af/0x1db0 drivers/tty/n_tty.c:2158
3 locks held by kworker/0:11/3730:
#0: ffff888017070938 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 kernel/workqueue.c:2283
#1: ffffc900051ffd20 ((work_completion)(&pwq->unbound_release_work)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 kernel/workqueue.c:2285
#2: ffffffff8c9241e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:290 [inline]
#2: ffffffff8c9241e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x280/0x740 kernel/rcu/tree_exp.h:845
1 lock held by udevd/4077:
2 locks held by kworker/0:16/4831:
#0: ffff888017072138 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 kernel/workqueue.c:2283
#1: ffffc9000532fd20 ((work_completion)(&rew.rew_work)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 kernel/workqueue.c:2285
10 locks held by kworker/1:35/5175:
2 locks held by kworker/u4:13/5310:
#0: ffff888079829138 ((wq_completion)btrfs-endio-write){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 kernel/workqueue.c:2283
#1: ffffc90002de7d20 ((work_completion)(&work->normal_work)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 kernel/workqueue.c:2285
3 locks held by syz.1.454/5711:
#0: ffff88801f06e328 (&mm->mmap_lock){++++}-{3:3}, at: mmap_read_trylock include/linux/mmap_lock.h:136 [inline]
#0: ffff88801f06e328 (&mm->mmap_lock){++++}-{3:3}, at: do_user_addr_fault arch/x86/mm/fault.c:1298 [inline]
#0: ffff88801f06e328 (&mm->mmap_lock){++++}-{3:3}, at: handle_page_fault arch/x86/mm/fault.c:1445 [inline]
#0: ffff88801f06e328 (&mm->mmap_lock){++++}-{3:3}, at: exc_page_fault+0x181/0x700 arch/x86/mm/fault.c:1501
#1: ffff888059bf8558 (
sb_pagefaults
#4){.+.+}-{0:0}, at: do_page_mkwrite+0x1a9/0x440 mm/memory.c:2909
#2: ffff888063697a58 (&ei->i_mmap_lock){++++}-{3:3}, at: btrfs_page_mkwrite+0x4a2/0xd60 fs/btrfs/inode.c:8950
2 locks held by btrfs-cleaner/5757:
#0: ffff888059bf8460 (sb_writers#13){.+.+}-{0:0}, at: cleaner_kthread+0x205/0x390 fs/btrfs/disk-io.c:1829
#1: ffff888063697bd0 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: inode_lock include/linux/fs.h:789 [inline]
#1: ffff888063697bd0 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: btrfs_inode_lock+0x49/0xd0 fs/btrfs/inode.c:124
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.168-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e3/0x2d0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x46a/0x4a0 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x181/0x2a0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:210 [inline]
watchdog+0xe72/0xeb0 kernel/hung_task.c:295
kthread+0x3f6/0x4f0 kernel/kthread.c:334
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 5175 Comm: kworker/1:35 Not tainted 5.15.168-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
Workqueue: usb_hub_wq hub_event
RIP: 0010:on_stack arch/x86/include/asm/stacktrace.h:58 [inline]
RIP: 0010:stack_access_ok arch/x86/kernel/unwind_orc.c:347 [inline]
RIP: 0010:deref_stack_reg arch/x86/kernel/unwind_orc.c:357 [inline]
RIP: 0010:unwind_next_frame+0xac4/0x1fa0 arch/x86/kernel/unwind_orc.c:539
Code: c1 e8 03 80 3c 10 00 74 0f e8 68 99 91 00 48 ba 00 00 00 00 00 fc ff df 48 89 5c 24 58 49 8b 6f 10 48 8b 44 24 38 0f b6 04 10 <84> c0 0f 85 80 0f 00 00 48 8b 04 24 48 8d 58 f8 41 83 3f 00 74 18
RSP: 0018:ffffc90000dd0348 EFLAGS: 00000246
RAX: 0000000000000000 RBX: ffffffff8eaef84f RCX: ffffffff8e2c3cc4
RDX: dffffc0000000000 RSI: 0000000000000000 RDI: ffffc90000dd0410
RBP: ffffc900051c0000 R08: 0000000000000006 R09: ffffc90000dd04f0
R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffffffff1d5df09
R13: 1ffffffff1d5df09 R14: ffffc900051b8000 R15: ffffc90000dd0400
FS: 0000000000000000(0000) GS:ffff8880b9100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f31fc81b178 CR3: 0000000028891000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
arch_stack_walk+0x10d/0x140 arch/x86/kernel/stacktrace.c:25
stack_trace_save+0x113/0x1c0 kernel/stacktrace.c:122
kasan_save_stack mm/kasan/common.c:38 [inline]
kasan_set_track mm/kasan/common.c:46 [inline]
set_alloc_info mm/kasan/common.c:434 [inline]
__kasan_slab_alloc+0x8e/0xc0 mm/kasan/common.c:467
kasan_slab_alloc include/linux/kasan.h:254 [inline]
slab_post_alloc_hook+0x53/0x380 mm/slab.h:519
slab_alloc_node mm/slub.c:3220 [inline]
kmem_cache_alloc_node+0x121/0x2c0 mm/slub.c:3256
__alloc_skb+0xdd/0x590 net/core/skbuff.c:415
skb_copy+0x127/0x820 net/core/skbuff.c:1595
mac80211_hwsim_tx_frame_no_nl+0xe37/0x1840 drivers/net/wireless/mac80211_hwsim.c:1569
mac80211_hwsim_tx_frame+0x1cc/0x220 drivers/net/wireless/mac80211_hwsim.c:1788
mac80211_hwsim_beacon_tx+0x48f/0x8a0 drivers/net/wireless/mac80211_hwsim.c:1842
__iterate_interfaces+0x21e/0x4b0 net/mac80211/util.c:793
ieee80211_iterate_active_interfaces_atomic+0xaf/0x140 net/mac80211/util.c:829
mac80211_hwsim_beacon+0xa7/0x180 drivers/net/wireless/mac80211_hwsim.c:1865
__run_hrtimer kernel/time/hrtimer.c:1688 [inline]
__hrtimer_run_queues+0x598/0xcf0 kernel/time/hrtimer.c:1752
hrtimer_run_softirq+0x196/0x2c0 kernel/time/hrtimer.c:1769
handle_softirqs+0x3a7/0x930 kernel/softirq.c:558
__do_softirq kernel/softirq.c:592 [inline]
invoke_softirq kernel/softirq.c:432 [inline]
__irq_exit_rcu+0x157/0x240 kernel/softirq.c:641
irq_exit_rcu+0x5/0x20 kernel/softirq.c:653
instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1096 [inline]
sysvec_apic_timer_interrupt+0xa0/0xc0 arch/x86/kernel/apic/apic.c:1096
asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:676
RIP: 0010:console_unlock+0xe53/0x12b0 kernel/printk/printk.c:2749
Code: 00 48 83 7c 24 18 00 75 19 e8 c9 05 1a 00 eb 18 e8 c2 05 1a 00 e8 4d e1 cd 08 48 83 7c 24 18 00 74 e7 e8 b0 05 1a 00 fb 31 ff <44> 89 f6 e8 05 09 1a 00 31 db 45 85 f6 0f 95 c0 89 c1 0a 4c 24 17
RSP: 0018:ffffc900051be160 EFLAGS: 00000246
RAX: ffffffff81666d80 RBX: 0000000000000000 RCX: 0000000000100000
RDX: ffffc9000defd000 RSI: 00000000000e7103 RDI: 0000000000000000
RBP: ffffc900051be3f0 R08: ffffffff81666d4b R09: fffffbfff20ec621
R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffffffff1a4c62e
R13: ffffffff8d2631a8 R14: 0000000000000000 R15: dffffc0000000000
vprintk_emit+0xbf/0x150 kernel/printk/printk.c:2274
dev_vprintk_emit+0x2aa/0x330 drivers/base/core.c:4621
dev_printk_emit+0xd9/0x120 drivers/base/core.c:4632
__netdev_printk+0x335/0x410 net/core/dev.c:11468
netdev_warn+0x11e/0x170 net/core/dev.c:11521
asix_read_cmd drivers/net/usb/asix_common.c:33 [inline]
asix_check_host_enable drivers/net/usb/asix_common.c:81 [inline]
asix_mdio_read+0x2a5/0x610 drivers/net/usb/asix_common.c:503
__mdiobus_read+0xa1/0x1a0 drivers/net/phy/mdio_bus.c:760
mdiobus_read+0x33/0x50 drivers/net/phy/mdio_bus.c:867
get_phy_c22_id drivers/net/phy/phy_device.c:845 [inline]
get_phy_device+0x129/0x360 drivers/net/phy/phy_device.c:922
mdiobus_scan+0xf3/0x470
__mdiobus_register+0x56d/0x810 drivers/net/phy/mdio_bus.c:588
__devm_mdiobus_register+0x6d/0xf0 drivers/net/phy/mdio_devres.c:87
ax88772_init_mdio drivers/net/usb/asix_devices.c:676 [inline]
ax88772_bind+0x965/0x1150 drivers/net/usb/asix_devices.c:807
usbnet_probe+0xb84/0x2880 drivers/net/usb/usbnet.c:1763
usb_probe_interface+0x5c0/0xaf0 drivers/usb/core/driver.c:396
really_probe+0x24e/0xb60 drivers/base/dd.c:595
__driver_probe_device+0x1a2/0x3d0 drivers/base/dd.c:755
driver_probe_device+0x50/0x420 drivers/base/dd.c:785
__device_attach_driver+0x2b9/0x500 drivers/base/dd.c:907
bus_for_each_drv+0x183/0x200 drivers/base/bus.c:429
__device_attach+0x359/0x570 drivers/base/dd.c:979
bus_probe_device+0xba/0x1e0 drivers/base/bus.c:489
device_add+0xb48/0xfd0 drivers/base/core.c:3415
usb_set_configuration+0x19dd/0x2020 drivers/usb/core/message.c:2165
usb_generic_driver_probe+0x84/0x140 drivers/usb/core/generic.c:238
usb_probe_device+0x130/0x260 drivers/usb/core/driver.c:293
really_probe+0x24e/0xb60 drivers/base/dd.c:595
__driver_probe_device+0x1a2/0x3d0 drivers/base/dd.c:755
driver_probe_device+0x50/0x420 drivers/base/dd.c:785
__device_attach_driver+0x2b9/0x500 drivers/base/dd.c:907
bus_for_each_drv+0x183/0x200 drivers/base/bus.c:429
__device_attach+0x359/0x570 drivers/base/dd.c:979
bus_probe_device+0xba/0x1e0 drivers/base/bus.c:489
device_add+0xb48/0xfd0 drivers/base/core.c:3415
usb_new_device+0xc17/0x18e0 drivers/usb/core/hub.c:2593
hub_port_connect drivers/usb/core/hub.c:5455 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5595 [inline]
port_event drivers/usb/core/hub.c:5741 [inline]
hub_event+0x2cdf/0x54c0 drivers/usb/core/hub.c:5823
process_one_work+0x8a1/0x10c0 kernel/workqueue.c:2310
worker_thread+0xaca/0x1280 kernel/workqueue.c:2457
kthread+0x3f6/0x4f0 kernel/kthread.c:334
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287