====================================================== WARNING: possible circular locking dependency detected 4.19.211-syzkaller #0 Not tainted ------------------------------------------------------ kworker/0:2/4683 is trying to acquire lock: 000000007f78a969 (&sb->s_type->i_mutex_key#10){++++}, at: inode_lock include/linux/fs.h:748 [inline] 000000007f78a969 (&sb->s_type->i_mutex_key#10){++++}, at: __generic_file_fsync+0xb0/0x1f0 fs/libfs.c:989 but task is already holding lock: 0000000006deaad8 ((work_completion)(&dio->complete_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #2 ((work_completion)(&dio->complete_work)){+.+.}: worker_thread+0x64c/0x1130 kernel/workqueue.c:2296 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 -> #1 ((wq_completion)"dio/%s"sb->s_id){+.+.}: drain_workqueue+0x1a5/0x460 kernel/workqueue.c:2826 destroy_workqueue+0x75/0x790 kernel/workqueue.c:4183 __alloc_workqueue_key+0xb76/0xed0 kernel/workqueue.c:4160 sb_init_dio_done_wq+0x34/0x90 fs/direct-io.c:623 dio_set_defer_completion fs/direct-io.c:646 [inline] get_more_blocks fs/direct-io.c:724 [inline] do_direct_IO fs/direct-io.c:1003 [inline] do_blockdev_direct_IO fs/direct-io.c:1333 [inline] __blockdev_direct_IO+0x83a8/0xef40 fs/direct-io.c:1419 ext4_direct_IO_write fs/ext4/inode.c:3777 [inline] ext4_direct_IO+0xae4/0x1c50 fs/ext4/inode.c:3915 generic_file_direct_write+0x208/0x4a0 mm/filemap.c:3073 __generic_file_write_iter+0x2d0/0x610 mm/filemap.c:3252 ext4_file_write_iter+0x957/0xf20 fs/ext4/file.c:272 call_write_iter include/linux/fs.h:1821 [inline] aio_write+0x37f/0x5c0 fs/aio.c:1574 __io_submit_one fs/aio.c:1858 [inline] io_submit_one+0xecd/0x20c0 fs/aio.c:1909 __do_sys_io_submit fs/aio.c:1953 [inline] __se_sys_io_submit+0x11b/0x4a0 fs/aio.c:1924 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #0 (&sb->s_type->i_mutex_key#10){++++}: down_write+0x34/0x90 kernel/locking/rwsem.c:70 inode_lock include/linux/fs.h:748 [inline] __generic_file_fsync+0xb0/0x1f0 fs/libfs.c:989 ext4_sync_file+0xa35/0x1420 fs/ext4/fsync.c:118 vfs_fsync_range+0x13a/0x220 fs/sync.c:197 generic_write_sync include/linux/fs.h:2750 [inline] dio_complete+0x763/0xac0 fs/direct-io.c:329 process_one_work+0x864/0x1570 kernel/workqueue.c:2153 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 other info that might help us debug this: Chain exists of: &sb->s_type->i_mutex_key#10 --> (wq_completion)"dio/%s"sb->s_id --> (work_completion)(&dio->complete_work) Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock((work_completion)(&dio->complete_work)); lock((wq_completion)"dio/%s"sb->s_id); lock((work_completion)(&dio->complete_work)); lock(&sb->s_type->i_mutex_key#10); *** DEADLOCK *** 2 locks held by kworker/0:2/4683: #0: 00000000787e7ad5 ((wq_completion)"dio/%s"sb->s_id){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 #1: 0000000006deaad8 ((work_completion)(&dio->complete_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 stack backtrace: CPU: 0 PID: 4683 Comm: kworker/0:2 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 Workqueue: dio/sda1 dio_aio_complete_work Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 print_circular_bug.constprop.0.cold+0x2d7/0x41e kernel/locking/lockdep.c:1222 check_prev_add kernel/locking/lockdep.c:1866 [inline] check_prevs_add kernel/locking/lockdep.c:1979 [inline] validate_chain kernel/locking/lockdep.c:2420 [inline] __lock_acquire+0x30c9/0x3ff0 kernel/locking/lockdep.c:3416 lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3908 down_write+0x34/0x90 kernel/locking/rwsem.c:70 inode_lock include/linux/fs.h:748 [inline] __generic_file_fsync+0xb0/0x1f0 fs/libfs.c:989 ext4_sync_file+0xa35/0x1420 fs/ext4/fsync.c:118 vfs_fsync_range+0x13a/0x220 fs/sync.c:197 generic_write_sync include/linux/fs.h:2750 [inline] dio_complete+0x763/0xac0 fs/direct-io.c:329 process_one_work+0x864/0x1570 kernel/workqueue.c:2153 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 IPVS: ftp: loaded support on port[0] = 21 kauditd_printk_skb: 102 callbacks suppressed audit: type=1804 audit(1663396788.291:467): pid=9818 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir1129855977/syzkaller.1GiU29/59/cgroup.controllers" dev="sda1" ino=14547 res=1 IPVS: ftp: loaded support on port[0] = 21 audit: type=1804 audit(1663396788.451:468): pid=9889 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir1129855977/syzkaller.1GiU29/60/cgroup.controllers" dev="sda1" ino=14467 res=1 IPVS: ftp: loaded support on port[0] = 21 IPVS: ftp: loaded support on port[0] = 21 IPVS: ftp: loaded support on port[0] = 21 audit: type=1804 audit(1663396789.541:469): pid=10004 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir1129855977/syzkaller.1GiU29/61/cgroup.controllers" dev="sda1" ino=14255 res=1 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 28 bytes leftover after parsing attributes in process `syz-executor.0'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 28 bytes leftover after parsing attributes in process `syz-executor.0'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. IPVS: ftp: loaded support on port[0] = 21 IPVS: ftp: loaded support on port[0] = 21 EXT4-fs error (device sda1): mb_free_blocks:1452: group 5, inode 15073: block 184350:freeing already freed block (bit 20510); block bitmap corrupt. EXT4-fs error (device sda1): ext4_mb_generate_buddy:744: group 5, block bitmap and bg descriptor inconsistent: 13251 vs 13262 free clusters EXT4-fs (sda1): pa 0000000058de809f: logic 32768, phys. 184320, len 2048 EXT4-fs error (device sda1): ext4_mb_release_inode_pa:3864: group 5, free 2018, pa_free 2007 net_ratelimit: 3 callbacks suppressed Dead loop on virtual device ip6_vti0, fix it urgently! wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 Dead loop on virtual device ip6_vti0, fix it urgently! wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 EXT4-fs error (device sda1): mb_free_blocks:1452: group 7, inode 13893: block 231454:freeing already freed block (bit 2078); block bitmap corrupt. EXT4-fs error (device sda1): ext4_mb_generate_buddy:744: group 7, block bitmap and bg descriptor inconsistent: 32725 vs 32736 free clusters IPVS: ftp: loaded support on port[0] = 21 EXT4-fs (sda1): pa 000000000d033c10: logic 32768, phys. 231424, len 2048 EXT4-fs error (device sda1): ext4_mb_release_inode_pa:3864: group 7, free 2018, pa_free 2007 Dead loop on virtual device ip6_vti0, fix it urgently! IPVS: ftp: loaded support on port[0] = 21 Dead loop on virtual device ip6_vti0, fix it urgently! Dead loop on virtual device ip6_vti0, fix it urgently! Dead loop on virtual device ip6_vti0, fix it urgently! Dead loop on virtual device ip6_vti0, fix it urgently! wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 Dead loop on virtual device ip6_vti0, fix it urgently! Dead loop on virtual device ip6_vti0, fix it urgently! wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 EXT4-fs error (device sda1): mb_free_blocks:1452: group 9, inode 15010: block 296990:freeing already freed block (bit 2078); block bitmap corrupt. Dead loop on virtual device ip6_vti0, fix it urgently! EXT4-fs error (device sda1): ext4_mb_generate_buddy:744: group 9, block bitmap and bg descriptor inconsistent: 32725 vs 32736 free clusters EXT4-fs (sda1): pa 00000000f1c4ff32: logic 32768, phys. 296960, len 2048 EXT4-fs error (device sda1): ext4_mb_release_inode_pa:3864: group 9, free 2018, pa_free 2007 EXT4-fs error (device sda1): mb_free_blocks:1452: group 11, inode 14320: block 360478:freeing already freed block (bit 30); block bitmap corrupt. EXT4-fs (sda1): pa 00000000aa6742d6: logic 32768, phys. 360448, len 2048 audit: type=1804 audit(1663396793.391:470): pid=10501 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2285892061/syzkaller.jkeesx/1085/file0" dev="sda1" ino=14979 res=1 audit: type=1804 audit(1663396793.501:471): pid=10511 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2285892061/syzkaller.jkeesx/1086/file0" dev="sda1" ino=14259 res=1 audit: type=1804 audit(1663396794.281:472): pid=10550 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2285892061/syzkaller.jkeesx/1087/file0" dev="sda1" ino=15186 res=1 audit: type=1804 audit(1663396794.311:473): pid=10550 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.2" name="/root/syzkaller-testdir2285892061/syzkaller.jkeesx/1087/file0" dev="sda1" ino=15186 res=1 audit: type=1804 audit(1663396794.311:474): pid=10561 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2285892061/syzkaller.jkeesx/1087/file0" dev="sda1" ino=15186 res=1 netlink: 124 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 44 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 124 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 44 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 124 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 44 bytes leftover after parsing attributes in process `syz-executor.2'.