================================ WARNING: inconsistent lock state 4.14.307-syzkaller #0 Not tainted -------------------------------- inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. systemd-udevd/10038 [HC0[0]:SC1[1]:HE1:SE0] takes: (&(&local->client_conns_lock)->rlock){+.?.}, at: [] spin_lock include/linux/spinlock.h:317 [inline] (&(&local->client_conns_lock)->rlock){+.?.}, at: [] rxrpc_put_one_client_conn net/rxrpc/conn_client.c:905 [inline] (&(&local->client_conns_lock)->rlock){+.?.}, at: [] rxrpc_put_client_conn+0x661/0xac0 net/rxrpc/conn_client.c:957 {SOFTIRQ-ON-W} state was registered at: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] rxrpc_get_client_conn net/rxrpc/conn_client.c:306 [inline] rxrpc_connect_call+0x2bb/0x3e10 net/rxrpc/conn_client.c:692 rxrpc_new_client_call+0x8f4/0x1a10 net/rxrpc/call_object.c:276 rxrpc_new_client_call_for_sendmsg net/rxrpc/sendmsg.c:531 [inline] rxrpc_do_sendmsg+0x8dc/0xfb0 net/rxrpc/sendmsg.c:583 rxrpc_sendmsg+0x3cf/0x5f0 net/rxrpc/af_rxrpc.c:543 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+0x5e/0xd3 irq event stamp: 742 hardirqs last enabled at (742): [] __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] hardirqs last enabled at (742): [] _raw_spin_unlock_irqrestore+0x79/0xe0 kernel/locking/spinlock.c:192 hardirqs last disabled at (741): [] __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:108 [inline] hardirqs last disabled at (741): [] _raw_spin_lock_irqsave+0x66/0xc0 kernel/locking/spinlock.c:160 softirqs last enabled at (0): [] copy_process.part.0+0x12d0/0x71c0 kernel/fork.c:1734 softirqs last disabled at (703): [] invoke_softirq kernel/softirq.c:368 [inline] softirqs last disabled at (703): [] irq_exit+0x193/0x240 kernel/softirq.c:409 other info that might help us debug this: Possible unsafe locking scenario: CPU0 ---- lock(&(&local->client_conns_lock)->rlock); lock(&(&local->client_conns_lock)->rlock); *** DEADLOCK *** 2 locks held by systemd-udevd/10038: #0: (&mm->mmap_sem){++++}, at: [] __do_page_fault+0x2b9/0xad0 arch/x86/mm/fault.c:1371 #1: (rcu_callback){....}, at: [] __rcu_reclaim kernel/rcu/rcu.h:185 [inline] #1: (rcu_callback){....}, at: [] rcu_do_batch kernel/rcu/tree.c:2699 [inline] #1: (rcu_callback){....}, at: [] invoke_rcu_callbacks kernel/rcu/tree.c:2962 [inline] #1: (rcu_callback){....}, at: [] __rcu_process_callbacks kernel/rcu/tree.c:2929 [inline] #1: (rcu_callback){....}, at: [] rcu_process_callbacks+0x84e/0x1180 kernel/rcu/tree.c:2946 stack backtrace: CPU: 0 PID: 10038 Comm: systemd-udevd Not tainted 4.14.307-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 print_usage_bug.cold+0x42e/0x570 kernel/locking/lockdep.c:2589 valid_state kernel/locking/lockdep.c:2602 [inline] mark_lock_irq kernel/locking/lockdep.c:2796 [inline] mark_lock+0xb4d/0x1050 kernel/locking/lockdep.c:3194 mark_irqflags kernel/locking/lockdep.c:3072 [inline] __lock_acquire+0xc81/0x3f20 kernel/locking/lockdep.c:3448 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] rxrpc_put_one_client_conn net/rxrpc/conn_client.c:905 [inline] rxrpc_put_client_conn+0x661/0xac0 net/rxrpc/conn_client.c:957 rxrpc_put_connection net/rxrpc/ar-internal.h:862 [inline] rxrpc_rcu_destroy_call+0x83/0x190 net/rxrpc/call_object.c:653 __rcu_reclaim kernel/rcu/rcu.h:195 [inline] rcu_do_batch kernel/rcu/tree.c:2699 [inline] invoke_rcu_callbacks kernel/rcu/tree.c:2962 [inline] __rcu_process_callbacks kernel/rcu/tree.c:2929 [inline] rcu_process_callbacks+0x780/0x1180 kernel/rcu/tree.c:2946 __do_softirq+0x24d/0x9ff kernel/softirq.c:288 invoke_softirq kernel/softirq.c:368 [inline] irq_exit+0x193/0x240 kernel/softirq.c:409 exiting_irq arch/x86/include/asm/apic.h:638 [inline] smp_apic_timer_interrupt+0x141/0x5e0 arch/x86/kernel/apic/apic.c:1106 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:796 RIP: 0010:find_vma+0xcf/0x150 mm/mmap.c:2165 RSP: 0000:ffff88805b527e80 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10 RAX: 1ffff11013a566f0 RBX: ffff88809d2b3798 RCX: 0000000000000001 RDX: 0000000000000000 RSI: 00007ffd23e25fc8 RDI: ffff88809d2b3780 RBP: 00007ffd23e25fc8 R08: 0000000000000001 R09: 0000000000058408 R10: ffff88805b47ec48 R11: ffff88805b47e3c0 R12: 0000000000000000 R13: dffffc0000000000 R14: 0000000000000001 R15: ffff88805b47e3c0 __do_page_fault+0x2ec/0xad0 arch/x86/mm/fault.c:1388 page_fault+0x45/0x50 arch/x86/entry/entry_64.S:1126 RIP: 23e26678: (null) RSP: 23e26540:00007ffd23e26530 EFLAGS: 55e266c4f23b hub 5-0:1.0: USB hub found hub 5-0:1.0: 1 port detected hub 5-0:1.0: USB hub found hub 5-0:1.0: 1 port detected device veth1_macvtap left promiscuous mode hub 5-0:1.0: USB hub found hub 5-0:1.0: 1 port detected BTRFS: device fsid 24c7a497-3402-47dd-bef8-82358f5f30e0 devid 1 transid 8 /dev/loop4 BTRFS info (device loop4): enabling inode map caching hub 5-0:1.0: USB hub found hub 5-0:1.0: 1 port detected BTRFS info (device loop4): force clearing of disk cache BTRFS info (device loop4): disabling free space tree BTRFS info (device loop4): has skinny extents BTRFS error (device loop4): open_ctree failed unregister_netdevice: waiting for ip6gre0 to become free. Usage count = -1 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready hub 5-0:1.0: USB hub found hub 5-0:1.0: 1 port detected IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. IPv6: ADDRCONF(NETDEV_UP): vlan4: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan5: link is not ready netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'. IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan4: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan5: link is not ready 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.0'. IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'. IPv6: ADDRCONF(NETDEV_UP): vlan4: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan5: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'. XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready syz-executor.5 (10427) used greatest stack depth: 24008 bytes left XFS (loop5): Unmounting Filesystem netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready IPv6: ADDRCONF(NETDEV_UP): vlan2: link is not ready EXT4-fs (loop1): mounted filesystem without journal. Opts: ,errors=continue IPv6: ADDRCONF(NETDEV_UP): vlan3: link is not ready EXT4-fs (loop1): mounted filesystem without journal. Opts: ,errors=continue EXT4-fs (loop1): mounted filesystem without journal. Opts: ,errors=continue XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. sit: Dst spoofed 0.0.0.0/::600:6300:6000:2002:b000 -> 0.0.0.0/2002:e000:0:300:8:2c:: XFS (loop5): Unmounting Filesystem sit: Dst spoofed 0.0.0.0/::600:6300:6000:2002:b000 -> 0.0.0.0/2002:e000:0:300:8:2c:: EXT4-fs (loop1): mounted filesystem without journal. Opts: ,errors=continue sit: Dst spoofed 0.0.0.0/::600:6300:6000:2002:b000 -> 0.0.0.0/2002:e000:0:300:8:2c:: sit: Dst spoofed 0.0.0.0/::600:6300:6000:2002:b000 -> 0.0.0.0/2002:e000:0:300:8:2c:: EXT4-fs (loop3): Ignoring removed nobh option EXT4-fs (loop3): ext4_check_descriptors: Inode bitmap for group 0 not in group (block 0)! EXT4-fs (loop3): group descriptors corrupted! XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. XFS (loop5): Unmounting Filesystem