====================================================== WARNING: possible circular locking dependency detected 4.14.290-syzkaller #0 Not tainted ------------------------------------------------------ kworker/u4:4/2881 is trying to acquire lock: (sk_lock-AF_INET){+.+.}, at: [] do_strp_work net/strparser/strparser.c:415 [inline] (sk_lock-AF_INET){+.+.}, at: [] strp_work+0x3e/0x100 net/strparser/strparser.c:434 but task is already holding lock: ((&strp->work)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 ((&strp->work)){+.+.}: flush_work+0xad/0x770 kernel/workqueue.c:2890 __cancel_work_timer+0x321/0x460 kernel/workqueue.c:2965 strp_done+0x53/0xd0 net/strparser/strparser.c:519 kcm_attach net/kcm/kcmsock.c:1429 [inline] kcm_attach_ioctl net/kcm/kcmsock.c:1490 [inline] kcm_ioctl+0x828/0xfb0 net/kcm/kcmsock.c:1701 sock_do_ioctl net/socket.c:974 [inline] sock_ioctl+0x2cc/0x4c0 net/socket.c:1071 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb -> #0 (sk_lock-AF_INET){+.+.}: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 lock_sock_nested+0xb7/0x100 net/core/sock.c:2813 do_strp_work net/strparser/strparser.c:415 [inline] strp_work+0x3e/0x100 net/strparser/strparser.c:434 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 other info that might help us debug this: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock((&strp->work)); lock(sk_lock-AF_INET); lock((&strp->work)); lock(sk_lock-AF_INET); *** DEADLOCK *** 2 locks held by kworker/u4:4/2881: #0: ("%s""kstrp"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&strp->work)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 stack backtrace: CPU: 1 PID: 2881 Comm: kworker/u4:4 Not tainted 4.14.290-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022 Workqueue: kstrp strp_work Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 print_circular_bug.constprop.0.cold+0x2d7/0x41e kernel/locking/lockdep.c:1258 check_prev_add kernel/locking/lockdep.c:1905 [inline] check_prevs_add kernel/locking/lockdep.c:2022 [inline] validate_chain kernel/locking/lockdep.c:2464 [inline] __lock_acquire+0x2e0e/0x3f20 kernel/locking/lockdep.c:3491 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 lock_sock_nested+0xb7/0x100 net/core/sock.c:2813 do_strp_work net/strparser/strparser.c:415 [inline] strp_work+0x3e/0x100 net/strparser/strparser.c:434 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 audit: type=1804 audit(1660219093.955:5): pid=10518 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.4" name="/root/syzkaller-testdir2340031770/syzkaller.WFpb2K/31/file0" dev="sda1" ino=14093 res=1 EXT4-fs (loop2): VFS: Can't find ext4 filesystem audit: type=1804 audit(1660219095.655:6): pid=10571 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.4" name="/root/syzkaller-testdir2340031770/syzkaller.WFpb2K/32/file0" dev="sda1" ino=14098 res=1 audit: type=1804 audit(1660219095.655:7): pid=10573 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2583651622/syzkaller.XrKDgd/48/file0" dev="sda1" ino=14099 res=1 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. bridge0: port 3(macvlan2) entered blocking state audit: type=1804 audit(1660219096.875:8): pid=10600 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2583651622/syzkaller.XrKDgd/49/file0" dev="sda1" ino=14117 res=1 bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode netlink: 4 bytes leftover after parsing attributes in process `syz-executor.1'. audit: type=1804 audit(1660219096.885:9): pid=10606 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir34679285/syzkaller.OL7ujr/31/file0" dev="sda1" ino=14118 res=1 EXT4-fs (loop2): VFS: Can't find ext4 filesystem device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state ISO 9660 Extensions: Microsoft Joliet Level 3 audit: type=1804 audit(1660219097.835:10): pid=10649 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2583651622/syzkaller.XrKDgd/50/file0" dev="sda1" ino=14102 res=1 audit: type=1804 audit(1660219097.955:11): pid=10656 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir34679285/syzkaller.OL7ujr/32/file0" dev="sda1" ino=14103 res=1 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 netlink: 4 bytes leftover after parsing attributes in process `syz-executor.4'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.2'. usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 netlink: 4 bytes leftover after parsing attributes in process `syz-executor.2'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 12 bytes leftover after parsing attributes in process `syz-executor.4'. usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 device macvlan2 entered promiscuous mode usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.5' sets config #0 netlink: 4 bytes leftover after parsing attributes in process `syz-executor.1'. device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 netlink: 4 bytes leftover after parsing attributes in process `syz-executor.3'. device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state syz-executor.4 (10738) used greatest stack depth: 24736 bytes left device macvlan2 entered promiscuous mode bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state bridge0: port 3(macvlan2) entered blocking state syz-executor.4 (10810) used greatest stack depth: 24416 bytes left bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode bridge0: port 3(macvlan2) entered blocking state bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode bridge0: port 3(macvlan2) entered blocking state usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.5' sets config #0 bridge0: port 3(macvlan2) entered disabled state device macvlan2 entered promiscuous mode device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state device macvlan2 left promiscuous mode bridge0: port 3(macvlan2) entered disabled state syz-executor.4 (10885) used greatest stack depth: 23968 bytes left usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.5' sets config #0 usb usb9: usbfs: interface 0 claimed by hub while 'syz-executor.0' sets config #0 sp0: Synchronizing with TNC ieee80211 phy2: Selected rate control algorithm 'minstrel_ht' ieee80211 phy2: hwaddr 02:00:00:00:02:00 registered ieee80211 phy3: Selected rate control algorithm 'minstrel_ht' ieee80211 phy3: hwaddr 02:00:00:00:03:00 registered sp0: Synchronizing with TNC ieee80211 phy4: Selected rate control algorithm 'minstrel_ht' sp0: Synchronizing with TNC ieee80211 phy4: hwaddr 02:00:00:00:04:00 registered sp0: Synchronizing with TNC ieee80211 phy5: Selected rate control algorithm 'minstrel_ht' ieee80211 phy5: hwaddr 02:00:00:00:05:00 registered ieee80211 phy6: Selected rate control algorithm 'minstrel_ht' ieee80211 phy6: hwaddr 02:00:00:00:06:00 registered nla_parse: 36 callbacks suppressed netlink: 12 bytes leftover after parsing attributes in process `syz-executor.0'. nbd: must specify a device to reconfigure