./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor2813054884 <...> Warning: Permanently added '10.128.1.135' (ED25519) to the list of known hosts. execve("./syz-executor2813054884", ["./syz-executor2813054884"], 0x7ffc70dc0800 /* 10 vars */) = 0 brk(NULL) = 0x555555d7c000 brk(0x555555d7cd40) = 0x555555d7cd40 arch_prctl(ARCH_SET_FS, 0x555555d7c3c0) = 0 set_tid_address(0x555555d7c690) = 5067 set_robust_list(0x555555d7c6a0, 24) = 0 rseq(0x555555d7cce0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor2813054884", 4096) = 28 getrandom("\xee\x26\xa0\x8e\x62\xa6\x5e\x8f", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555555d7cd40 brk(0x555555d9dd40) = 0x555555d9dd40 brk(0x555555d9e000) = 0x555555d9e000 mprotect(0x7f3d4f964000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 unshare(CLONE_NEWPID) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x555555d7c690) = 5068 ./strace-static-x86_64: Process 5068 attached [pid 5068] set_robust_list(0x555555d7c6a0, 24) = 0 [pid 5068] mount(NULL, "/sys/fs/fuse/connections", "fusectl", 0, NULL) = -1 EBUSY (Device or resource busy) [pid 5068] socket(AF_BLUETOOTH, SOCK_RAW, BTPROTO_HCI) = 3 [pid 5068] openat(AT_FDCWD, "/dev/vhci", O_RDWR) = 4 [pid 5068] dup2(4, 202) = 202 [pid 5068] close(4) = 0 [pid 5068] write(202, "\xff\x00", 2) = 2 [pid 5068] read(202, "\xff\x00\x00\x00", 4) = 4 [pid 5068] rt_sigaction(SIGRT_1, {sa_handler=0x7f3d4f906440, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f3d4f8f7ac0}, NULL, 8) = 0 [pid 5068] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 [pid 5068] mmap(NULL, 8392704, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7f3d4f0a1000 [pid 5068] mprotect(0x7f3d4f0a2000, 8388608, PROT_READ|PROT_WRITE) = 0 [pid 5068] rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 [pid 5068] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f3d4f8a1990, parent_tid=0x7f3d4f8a1990, exit_signal=0, stack=0x7f3d4f0a1000, stack_size=0x800300, tls=0x7f3d4f8a16c0} => {parent_tid=[2]}, 88) = 2 ./strace-static-x86_64: Process 5071 attached [pid 5068] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5068] ioctl(3, HCIDEVUP [pid 5071] rseq(0x7f3d4f8a1fe0, 0x20, 0, 0x53053053) = 0 [pid 5071] set_robust_list(0x7f3d4f8a19a0, 24) = 0 [pid 5071] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5071] read(202, "\x01\x03\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x03\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x03\x10\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x03\x10", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x01\x10\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x01\x10", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x09\x10\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\x0a", iov_len=2}, {iov_base="\x01\x09\x10", iov_len=3}, {iov_base="\x00\xaa\xaa\xaa\xaa\xaa\xaa", iov_len=7}], 4) = 13 [pid 5071] read(202, "\x01\x05\x10\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\x0b", iov_len=2}, {iov_base="\x01\x05\x10", iov_len=3}, {iov_base="\x00\xfd\x03\x60\x04\x00\x06\x00", iov_len=8}], 4) = 14 [pid 5071] read(202, "\x01\x23\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x23\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [ 73.084612][ T5069] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 73.105143][ T5069] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 73.113367][ T5069] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [pid 5071] read(202, "\x01\x14\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x14\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x25\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x25\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x38\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x38\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x39\x0c\x00", 1024) = 4 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x39\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, "\x01\x16\x0c\x02\x00\x7d", 1024) = 6 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\xfc", iov_len=2}, {iov_base="\x01\x16\x0c", iov_len=3}, {iov_base="\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., iov_len=249}], 4) = 255 [pid 5071] read(202, [pid 5068] <... ioctl resumed>, 0) = -1 EALREADY (Operation already in progress) [pid 5068] ioctl(3, HCISETSCAN [pid 5071] <... read resumed>"\x01\x1a\x0c\x01\x02", 1024) = 5 [pid 5071] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x0e\x04", iov_len=2}, {iov_base="\x01\x1a\x0c", iov_len=3}, {iov_base="\x00", iov_len=1}], 4) = 7 [ 73.148589][ T5069] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 73.167398][ T5069] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 73.176481][ T5069] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [pid 5071] rt_sigprocmask(SIG_BLOCK, ~[RT_1], [pid 5068] <... ioctl resumed>, 0x7ffd0f5ca204) = 0 [pid 5071] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5068] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x04\x0a", iov_len=2}, {iov_base="\xaa\xaa\xaa\xaa\xaa\x10\x00\x00\x00\x01", iov_len=10}], 3 [pid 5071] madvise(0x7f3d4f0a1000, 8372224, MADV_DONTNEED [pid 5068] <... writev resumed>) = 13 [pid 5068] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x03\x0b", iov_len=2}, {iov_base="\x00\xc8\x00\xaa\xaa\xaa\xaa\xaa\x10\x01\x00", iov_len=11}], 3 [pid 5071] <... madvise resumed>) = 0 [pid 5068] <... writev resumed>) = 14 [pid 5068] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\v\v", iov_len=2}, {iov_base="\x00\xc8\x00\x00\x00\x00\x00\x00\x00\x00\x00", iov_len=11}], 3) = 14 [pid 5068] writev(202, [{iov_base="\x04", iov_len=1}, {iov_base="\x3e\x13", iov_len=2}, {iov_base="\x01\x00\xc9\x00\x01\x00\xaa\xaa\xaa\xaa\xaa\x11\x00\x00\x00\x00\x00\x00\x00", iov_len=19}], 3 [pid 5071] exit(0 [pid 5068] <... writev resumed>) = 22 [pid 5068] futex(0x7f3d4f8a1990, FUTEX_WAIT_BITSET|FUTEX_CLOCK_REALTIME, 2, NULL, FUTEX_BITSET_MATCH_ANY [pid 5071] <... exit resumed>) = ? [pid 5071] +++ exited with 0 +++ [pid 5068] <... futex resumed>) = 0 [pid 5068] close(3) = 0 [pid 5068] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5068] setsid() = 1 [pid 5068] prlimit64(0, RLIMIT_AS, {rlim_cur=204800*1024, rlim_max=204800*1024}, NULL) = 0 [pid 5068] prlimit64(0, RLIMIT_MEMLOCK, {rlim_cur=32768*1024, rlim_max=32768*1024}, NULL) = 0 [pid 5068] prlimit64(0, RLIMIT_FSIZE, {rlim_cur=139264*1024, rlim_max=139264*1024}, NULL) = 0 [pid 5068] prlimit64(0, RLIMIT_STACK, {rlim_cur=1024*1024, rlim_max=1024*1024}, NULL) = 0 [pid 5068] prlimit64(0, RLIMIT_CORE, {rlim_cur=131072*1024, rlim_max=131072*1024}, NULL) = 0 [pid 5068] prlimit64(0, RLIMIT_NOFILE, {rlim_cur=256, rlim_max=256}, NULL) = 0 [pid 5068] unshare(CLONE_NEWNS) = 0 [pid 5068] mount(NULL, "/", NULL, MS_REC|MS_PRIVATE, NULL) = 0 [pid 5068] unshare(CLONE_NEWIPC) = 0 [pid 5068] unshare(CLONE_NEWCGROUP) = 0 [pid 5068] unshare(CLONE_NEWUTS) = 0 [pid 5068] unshare(CLONE_SYSVSEM) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/shmmax", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "16777216", 8) = 8 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/shmall", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "536870912", 9) = 9 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/shmmni", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "1024", 4) = 4 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/msgmax", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "8192", 4) = 4 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/msgmni", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "1024", 4) = 4 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/msgmnb", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "1024", 4) = 4 [pid 5068] close(3) = 0 [pid 5068] openat(AT_FDCWD, "/proc/sys/kernel/sem", O_WRONLY|O_CLOEXEC) = 3 [pid 5068] write(3, "1024 1048576 500 1024", 21) = 21 [pid 5068] close(3) = 0 [pid 5068] getpid() = 1 [pid 5068] capget({version=_LINUX_CAPABILITY_VERSION_3, pid=1}, {effective=1<tx_work)){+.+.}-{0:0}, at: __flush_work+0xfa/0xa10 [ 73.696673][ T5068] [ 73.696673][ T5068] but task is already holding lock: [ 73.704046][ T5068] ffff88807b08d108 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close+0x26/0x90 [ 73.713308][ T5068] [ 73.713308][ T5068] which lock already depends on the new lock. [ 73.713308][ T5068] [ 73.723729][ T5068] [ 73.723729][ T5068] the existing dependency chain (in reverse order) is: [ 73.732765][ T5068] [ 73.732765][ T5068] -> #3 (&hdev->req_lock){+.+.}-{3:3}: [ 73.740436][ T5068] __mutex_lock+0x175/0x9d0 [ 73.745490][ T5068] hci_dev_do_close+0x26/0x90 [ 73.751331][ T5068] hci_rfkill_set_block+0x1b9/0x200 [ 73.757080][ T5068] rfkill_set_block+0x200/0x550 [ 73.762471][ T5068] rfkill_fop_write+0x2d4/0x570 [ 73.767956][ T5068] vfs_write+0x2a4/0xdf0 [ 73.772722][ T5068] ksys_write+0x1f0/0x250 [ 73.777576][ T5068] do_syscall_64+0x40/0x110 [ 73.782608][ T5068] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 73.789296][ T5068] [ 73.789296][ T5068] -> #2 (rfkill_global_mutex){+.+.}-{3:3}: [ 73.797316][ T5068] __mutex_lock+0x175/0x9d0 [ 73.802366][ T5068] rfkill_register+0x3a/0xb30 [ 73.807572][ T5068] hci_register_dev+0x43a/0xd40 [ 73.812963][ T5068] __vhci_create_device+0x393/0x800 [ 73.818790][ T5068] vhci_write+0x2c7/0x470 [ 73.823729][ T5068] vfs_write+0x64f/0xdf0 [ 73.828488][ T5068] ksys_write+0x12f/0x250 [ 73.833354][ T5068] do_syscall_64+0x40/0x110 [ 73.838385][ T5068] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 73.844807][ T5068] [ 73.844807][ T5068] -> #1 (&data->open_mutex){+.+.}-{3:3}: [ 73.852627][ T5068] __mutex_lock+0x175/0x9d0 [ 73.857751][ T5068] vhci_send_frame+0x67/0xa0 [ 73.862869][ T5068] hci_send_frame+0x220/0x470 [ 73.868150][ T5068] hci_tx_work+0x1456/0x1e40 [ 73.873256][ T5068] process_one_work+0x886/0x15d0 [ 73.878719][ T5068] worker_thread+0x8b9/0x1290 [ 73.883927][ T5068] kthread+0x2c6/0x3a0 [ 73.888516][ T5068] ret_from_fork+0x45/0x80 [ 73.893473][ T5068] ret_from_fork_asm+0x11/0x20 [ 73.898761][ T5068] [ 73.898761][ T5068] -> #0 ((work_completion)(&hdev->tx_work)){+.+.}-{0:0}: [ 73.907970][ T5068] __lock_acquire+0x2433/0x3b20 [ 73.913358][ T5068] lock_acquire+0x1ae/0x520 [ 73.918383][ T5068] __flush_work+0x103/0xa10 [ 73.923406][ T5068] hci_dev_close_sync+0x22d/0x1160 [ 73.929045][ T5068] hci_dev_do_close+0x2e/0x90 [ 73.934262][ T5068] hci_rfkill_set_block+0x1b9/0x200 [ 73.940000][ T5068] rfkill_set_block+0x200/0x550 [ 73.945373][ T5068] rfkill_fop_write+0x2d4/0x570 [ 73.950749][ T5068] vfs_write+0x2a4/0xdf0 [ 73.955541][ T5068] ksys_write+0x1f0/0x250 [ 73.960383][ T5068] do_syscall_64+0x40/0x110 [ 73.965423][ T5068] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 73.971850][ T5068] [ 73.971850][ T5068] other info that might help us debug this: [ 73.971850][ T5068] [ 73.982071][ T5068] Chain exists of: [ 73.982071][ T5068] (work_completion)(&hdev->tx_work) --> rfkill_global_mutex --> &hdev->req_lock [ 73.982071][ T5068] [ 73.997027][ T5068] Possible unsafe locking scenario: [ 73.997027][ T5068] [ 74.004469][ T5068] CPU0 CPU1 [ 74.009819][ T5068] ---- ---- [ 74.015172][ T5068] lock(&hdev->req_lock); [ 74.019589][ T5068] lock(rfkill_global_mutex); [ 74.026892][ T5068] lock(&hdev->req_lock); [ 74.033822][ T5068] lock((work_completion)(&hdev->tx_work)); [ 74.039810][ T5068] [ 74.039810][ T5068] *** DEADLOCK *** [ 74.039810][ T5068] [ 74.047958][ T5068] 2 locks held by syz-executor281/5068: [ 74.053497][ T5068] #0: ffffffff8ef2d9e8 (rfkill_global_mutex){+.+.}-{3:3}, at: rfkill_fop_write+0x16e/0x570 [ 74.063692][ T5068] #1: ffff88807b08d108 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close+0x26/0x90 [ 74.073443][ T5068] [ 74.073443][ T5068] stack backtrace: [ 74.079319][ T5068] CPU: 0 PID: 5068 Comm: syz-executor281 Not tainted 6.7.0-rc5-syzkaller #0 [ 74.087993][ T5068] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 74.098041][ T5068] Call Trace: [ 74.101327][ T5068] [ 74.104251][ T5068] dump_stack_lvl+0xd9/0x1b0 [ 74.108841][ T5068] check_noncircular+0x317/0x400 [ 74.113782][ T5068] ? print_circular_bug+0x5c0/0x5c0 [ 74.118984][ T5068] ? is_bpf_text_address+0x94/0x1a0 [ 74.124194][ T5068] ? lockdep_lock+0xc6/0x200 [ 74.128791][ T5068] ? hlock_class+0x130/0x130 [ 74.133402][ T5068] __lock_acquire+0x2433/0x3b20 [ 74.138279][ T5068] ? lockdep_hardirqs_on_prepare+0x420/0x420 [ 74.144298][ T5068] ? save_trace+0x4e/0xb30 [ 74.148716][ T5068] ? _find_first_zero_bit+0x94/0xb0 [ 74.153924][ T5068] lock_acquire+0x1ae/0x520 [ 74.158448][ T5068] ? __flush_work+0xfa/0xa10 [ 74.163066][ T5068] ? lock_sync+0x190/0x190 [ 74.167510][ T5068] ? __flush_work+0xfa/0xa10 [ 74.172111][ T5068] __flush_work+0x103/0xa10 [ 74.176616][ T5068] ? __flush_work+0xfa/0xa10 [ 74.181210][ T5068] ? cancel_delayed_work+0x20/0x20 [ 74.186362][ T5068] hci_dev_close_sync+0x22d/0x1160 [ 74.191480][ T5068] ? find_held_lock+0x2d/0x110 [ 74.196256][ T5068] ? hci_reset_sync+0x50/0x50 [ 74.200948][ T5068] ? reacquire_held_locks+0x4c0/0x4c0 [ 74.206342][ T5068] hci_dev_do_close+0x2e/0x90 [ 74.211107][ T5068] hci_rfkill_set_block+0x1b9/0x200 [ 74.216311][ T5068] ? lockdep_hardirqs_on+0x7d/0x110 [ 74.224477][ T5068] ? hci_power_on+0x670/0x670 [ 74.229259][ T5068] rfkill_set_block+0x200/0x550 [ 74.234144][ T5068] rfkill_fop_write+0x2d4/0x570 [ 74.239014][ T5068] ? rfkill_register+0xb30/0xb30 [ 74.243953][ T5068] ? bpf_lsm_inode_killpriv+0x10/0x10 [ 74.249325][ T5068] ? security_file_permission+0x94/0x100 [ 74.255032][ T5068] vfs_write+0x2a4/0xdf0 [ 74.259282][ T5068] ? rfkill_register+0xb30/0xb30 [ 74.264241][ T5068] ? recalc_sigpending_tsk+0x187/0x1d0 [ 74.269700][ T5068] ? kernel_write+0x6c0/0x6c0 [ 74.274405][ T5068] ? find_held_lock+0x2d/0x110 [ 74.279438][ T5068] ? ptrace_notify+0xf4/0x130 [ 74.284123][ T5068] ? reacquire_held_locks+0x4c0/0x4c0 [ 74.289590][ T5068] ? __fget_light+0x1fc/0x260 [ 74.294263][ T5068] ksys_write+0x1f0/0x250 [ 74.298594][ T5068] ? __ia32_sys_read+0xb0/0xb0 [ 74.303371][ T5068] ? syscall_trace_enter.constprop.0+0xaf/0x1e0 [ 74.309640][ T5068] do_syscall_64+0x40/0x110 [ 74.314170][ T5068] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 74.320073][ T5068] RIP: 0033:0x7f3d4f8e0479 [ 74.324748][ T5068] Code: 48 83 c4 28 c3 e8 e7 18 00 00 0f 1f 80 00 00 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b0 ff ff ff f7 d8 64 89 01 48 [ 74.344545][ T5068] RSP: 002b:00007ffd0f5ca1e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [pid 5068] write(3, "\x00\x00\x00\x00\x00\x03\x01\x00", 8) = 8 [pid 5068] exit_group(1) = ? [ 74.353077][ T5068] RAX: ffffffffffffffda RBX: 00007f3d4f937043 RCX: 00007f3d4f8e0479 [ 74.361062][ T5068] RDX: 0000000000000008 RSI: 0000000020000080 RDI: 0000000000000003 [ 74.369211][ T5068] RBP: 00007ffd0f5ca230 R08: 000000ff00ffd650 R09: 000000ff00ffd650 [ 74.377447][ T5068] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffd0f5ca218 [ 74.385435][ T5068] R13: 00007f3d4f9645b0 R14: 0000000000000000 R15: 0000000000000001 [ 74.393409][ T5068] [pid 5068] +++ exited with 1 +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5068, si_uid=0, si_status=1, si_utime=0, si_stime=11 /* 0.11 s */} --- exit_group(0) = ? +++ exited with 0 +++