============================================ WARNING: possible recursive locking detected 4.14.284-syzkaller #0 Not tainted -------------------------------------------- syz-executor.3/10385 is trying to acquire lock: (&(&bond->stats_lock)->rlock#3/3){+.+.}, at: [] bond_get_stats+0xb7/0x440 drivers/net/bonding/bond_main.c:3457 but task is already holding lock: (&(&bond->stats_lock)->rlock#3/3){+.+.}, at: [] bond_get_stats+0xb7/0x440 drivers/net/bonding/bond_main.c:3457 other info that might help us debug this: Possible unsafe locking scenario: CPU0 ---- lock(&(&bond->stats_lock)->rlock#3/3); lock(&(&bond->stats_lock)->rlock#3/3); *** DEADLOCK *** May be due to missing lock nesting notation 3 locks held by syz-executor.3/10385: #0: (rtnl_mutex){+.+.}, at: [] rtnl_lock net/core/rtnetlink.c:72 [inline] #0: (rtnl_mutex){+.+.}, at: [] rtnetlink_rcv_msg+0x31d/0xb10 net/core/rtnetlink.c:4317 #1: (&(&bond->stats_lock)->rlock#3/3){+.+.}, at: [] bond_get_stats+0xb7/0x440 drivers/net/bonding/bond_main.c:3457 #2: (rcu_read_lock){....}, at: [] bond_get_nest_level drivers/net/bonding/bond_main.c:3446 [inline] #2: (rcu_read_lock){....}, at: [] bond_get_stats+0x9b/0x440 drivers/net/bonding/bond_main.c:3457 stack backtrace: CPU: 0 PID: 10385 Comm: syz-executor.3 Not tainted 4.14.284-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 print_deadlock_bug kernel/locking/lockdep.c:1800 [inline] check_deadlock kernel/locking/lockdep.c:1847 [inline] validate_chain kernel/locking/lockdep.c:2448 [inline] __lock_acquire.cold+0x180/0x97c kernel/locking/lockdep.c:3491 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 _raw_spin_lock_nested+0x30/0x40 kernel/locking/spinlock.c:362 bond_get_stats+0xb7/0x440 drivers/net/bonding/bond_main.c:3457 dev_get_stats+0xa5/0x280 net/core/dev.c:8019 bond_get_stats+0x1da/0x440 drivers/net/bonding/bond_main.c:3463 dev_get_stats+0xa5/0x280 net/core/dev.c:8019 rtnl_fill_stats+0x48/0xa90 net/core/rtnetlink.c:1079 rtnl_fill_ifinfo+0xe16/0x3050 net/core/rtnetlink.c:1385 rtmsg_ifinfo_build_skb+0x8e/0x130 net/core/rtnetlink.c:2915 rtmsg_ifinfo_event net/core/rtnetlink.c:2945 [inline] rtmsg_ifinfo_event net/core/rtnetlink.c:2936 [inline] rtnetlink_event+0xee/0x1a0 net/core/rtnetlink.c:4366 notifier_call_chain+0x108/0x1a0 kernel/notifier.c:93 call_netdevice_notifiers_info net/core/dev.c:1667 [inline] call_netdevice_notifiers net/core/dev.c:1683 [inline] netdev_features_change net/core/dev.c:1296 [inline] netdev_change_features+0x7e/0xa0 net/core/dev.c:7457 bond_compute_features+0x444/0x860 drivers/net/bonding/bond_main.c:1122 bond_slave_netdev_event drivers/net/bonding/bond_main.c:3191 [inline] bond_netdev_event+0x664/0xbd0 drivers/net/bonding/bond_main.c:3232 notifier_call_chain+0x108/0x1a0 kernel/notifier.c:93 call_netdevice_notifiers_info net/core/dev.c:1667 [inline] call_netdevice_notifiers net/core/dev.c:1683 [inline] netdev_features_change net/core/dev.c:1296 [inline] netdev_change_features+0x7e/0xa0 net/core/dev.c:7457 bond_compute_features+0x444/0x860 drivers/net/bonding/bond_main.c:1122 bond_enslave+0x37fb/0x4cf0 drivers/net/bonding/bond_main.c:1757 do_set_master+0x19e/0x200 net/core/rtnetlink.c:1961 rtnl_newlink+0x1356/0x1830 net/core/rtnetlink.c:2759 rtnetlink_rcv_msg+0x3be/0xb10 net/core/rtnetlink.c:4322 netlink_rcv_skb+0x125/0x390 net/netlink/af_netlink.c:2454 netlink_unicast_kernel net/netlink/af_netlink.c:1296 [inline] netlink_unicast+0x437/0x610 net/netlink/af_netlink.c:1322 netlink_sendmsg+0x648/0xbc0 net/netlink/af_netlink.c:1893 sock_sendmsg_nosec net/socket.c:646 [inline] sock_sendmsg+0xb5/0x100 net/socket.c:656 ___sys_sendmsg+0x6c8/0x800 net/socket.c:2062 __sys_sendmsg+0xa3/0x120 net/socket.c:2096 SYSC_sendmsg net/socket.c:2107 [inline] SyS_sendmsg+0x27/0x40 net/socket.c:2103 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f46c0a85109 RSP: 002b:00007f46bf3fa168 EFLAGS: 00000246 ORIG_RAX: 000000000000002e RAX: ffffffffffffffda RBX: 00007f46c0b97f60 RCX: 00007f46c0a85109 RDX: 0000000000000000 RSI: 0000000020000240 RDI: 0000000000000007 RBP: 00007f46c0adf05d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffcfa1338bf R14: 00007f46bf3fa300 R15: 0000000000022000 bond1: making interface vlan2 the new active one device bridge4 entered promiscuous mode bond1: Enslaving vlan2 as an active interface with an up link netlink: 4 bytes leftover after parsing attributes in process `syz-executor.2'. 8021q: adding VLAN 0 to HW filter on device bond3 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 bond0: Enslaving bond3 as an active interface with an up link device bridge3 entered promiscuous mode device bridge3 left promiscuous mode usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 bond3: making interface vlan4 the new active one device bridge3 entered promiscuous mode usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 bond3: Enslaving vlan4 as an active interface with an up link usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 netlink: 12 bytes leftover after parsing attributes in process `syz-executor.1'. bond1: making interface vlan2 the new active one usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.2' sets config #1 bond1: Enslaving vlan2 as an active interface with an up link usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.5' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.2' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.3' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.5' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.2' sets config #1 usb usb9: usbfs: interface 0 claimed by usbfs while 'syz-executor.5' sets config #1 netlink: 12 bytes leftover after parsing attributes in process `syz-executor.1'. bond3: making interface vlan3 the new active one bond3: Enslaving vlan3 as an active interface with an up link audit: type=1800 audit(1656080778.767:14): pid=10811 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="file0" dev="sda1" ino=14019 res=0 audit: type=1804 audit(1656080778.887:15): pid=10811 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/44/file0" dev="sda1" ino=14019 res=1 netlink: 12 bytes leftover after parsing attributes in process `syz-executor.1'. audit: type=1804 audit(1656080779.007:16): pid=10811 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/44/file0" dev="sda1" ino=14019 res=1 bond4: making interface vlan4 the new active one bond4: Enslaving vlan4 as an active interface with an up link audit: type=1800 audit(1656080780.687:17): pid=10834 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="file0" dev="sda1" ino=14020 res=0 audit: type=1804 audit(1656080780.807:18): pid=10834 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/45/file0" dev="sda1" ino=14020 res=1 audit: type=1804 audit(1656080780.837:19): pid=10834 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/45/file0" dev="sda1" ino=14020 res=1 audit: type=1800 audit(1656080781.547:20): pid=10886 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="file0" dev="sda1" ino=14016 res=0 audit: type=1804 audit(1656080781.557:21): pid=10886 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/46/file0" dev="sda1" ino=14016 res=1 audit: type=1804 audit(1656080781.567:22): pid=10886 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.5" name="/root/syzkaller-testdir2922165205/syzkaller.ptTsZK/46/file0" dev="sda1" ino=14016 res=1 audit: type=1800 audit(1656080782.387:23): pid=10923 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="file0" dev="sda1" ino=14034 res=0 unregister_netdevice: waiting for ip6gre0 to become free. Usage count = -1 NILFS (nullb0): couldn't find nilfs on the device FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop5): error, fat_get_cluster: invalid start cluster (i_pos 0, start f8000000) FAT-fs (loop5): error, fat_get_cluster: invalid start cluster (i_pos 0, start f8000000) FAT-fs (loop5): error, fat_get_cluster: invalid start cluster (i_pos 0, start f8000000) FAT-fs (loop5): error, fat_get_cluster: invalid start cluster (i_pos 0, start f8000000)