Warning: Permanently added '[localhost]:31511' (ECDSA) to the list of known hosts.
2022/09/14 11:17:09 fuzzer started
2022/09/14 11:17:10 dialing manager at localhost:33849
syzkaller login: [   44.816247] cgroup: Unknown subsys name 'net'
[   44.908630] cgroup: Unknown subsys name 'rlimit'
2022/09/14 11:17:24 syscalls: 2215
2022/09/14 11:17:24 code coverage: enabled
2022/09/14 11:17:24 comparison tracing: enabled
2022/09/14 11:17:24 extra coverage: enabled
2022/09/14 11:17:24 setuid sandbox: enabled
2022/09/14 11:17:24 namespace sandbox: enabled
2022/09/14 11:17:24 Android sandbox: enabled
2022/09/14 11:17:24 fault injection: enabled
2022/09/14 11:17:24 leak checking: enabled
2022/09/14 11:17:24 net packet injection: enabled
2022/09/14 11:17:24 net device setup: enabled
2022/09/14 11:17:24 concurrency sanitizer: /sys/kernel/debug/kcsan does not exist
2022/09/14 11:17:24 devlink PCI setup: PCI device 0000:00:10.0 is not available
2022/09/14 11:17:24 USB emulation: enabled
2022/09/14 11:17:24 hci packet injection: enabled
2022/09/14 11:17:24 wifi device emulation: failed to parse kernel version (6.0.0-rc5-next-20220914������������������������������������������)
2022/09/14 11:17:24 802.15.4 emulation: enabled
2022/09/14 11:17:24 fetching corpus: 0, signal 0/2000 (executing program)
2022/09/14 11:17:24 fetching corpus: 50, signal 38076/40798 (executing program)
2022/09/14 11:17:25 fetching corpus: 100, signal 49808/53301 (executing program)
2022/09/14 11:17:25 fetching corpus: 150, signal 55094/59368 (executing program)
2022/09/14 11:17:25 fetching corpus: 200, signal 61900/66597 (executing program)
2022/09/14 11:17:25 fetching corpus: 250, signal 70658/75542 (executing program)
2022/09/14 11:17:25 fetching corpus: 300, signal 75923/81043 (executing program)
2022/09/14 11:17:25 fetching corpus: 350, signal 79751/85162 (executing program)
2022/09/14 11:17:26 fetching corpus: 400, signal 84581/89907 (executing program)
2022/09/14 11:17:26 fetching corpus: 450, signal 88912/94066 (executing program)
2022/09/14 11:17:26 fetching corpus: 500, signal 93556/98255 (executing program)
2022/09/14 11:17:26 fetching corpus: 550, signal 96218/100715 (executing program)
2022/09/14 11:17:26 fetching corpus: 600, signal 98883/103099 (executing program)
2022/09/14 11:17:26 fetching corpus: 650, signal 101104/105032 (executing program)
2022/09/14 11:17:27 fetching corpus: 700, signal 103100/106867 (executing program)
2022/09/14 11:17:27 fetching corpus: 750, signal 106105/109205 (executing program)
2022/09/14 11:17:27 fetching corpus: 800, signal 108261/110898 (executing program)
2022/09/14 11:17:27 fetching corpus: 850, signal 111947/113935 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/114622 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/114719 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/114816 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/114917 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115009 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115102 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115209 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115295 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115383 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115488 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115576 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115669 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115763 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115849 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/115926 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/116008 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/116102 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/116180 (executing program)
2022/09/14 11:17:27 fetching corpus: 866, signal 112843/116275 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116373 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116464 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116545 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116629 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116737 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116817 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/116935 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117036 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117145 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117253 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117360 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117464 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117569 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117666 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117764 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117792 (executing program)
2022/09/14 11:17:28 fetching corpus: 866, signal 112843/117792 (executing program)
2022/09/14 11:17:30 starting 8 fuzzer processes
11:17:30 executing program 0:
r0 = socket$nl_route(0x10, 0x3, 0x0)
ioctl$BTRFS_IOC_SUBVOL_CREATE_V2(r0, 0x50009418, 0x0)

11:17:31 executing program 2:
syz_mount_image$vfat(&(0x7f0000000000), &(0x7f0000000100)='./file0\x00', 0x80000, 0x8, &(0x7f0000000200)=[{&(0x7f0000010000)="eb3c906d6b66732e66617400028001000270000004f80100200040000000000000000000800029e21b3bf153595a4b414c4c4552202046415431362020200e1fbe5b7cac22c0740b56b40ebb0700cd105eebf032e4cd16cd19ebfe54686973206973206e6f74206120626f6f7461626c65206469736b2e2020506c6561736520696e73657274206120626f6f7461626c6520666c6f70707920616e640d0a707265737320616e79206b657920746f2074727920616761696e202e2e2e200d0a00", 0xc0}, {&(0x7f0000010100)="00000000000000000000000000000000000000000000000000000000000055aaf8fffffff0ffffffffffffff00"/64, 0x40, 0x1e0}, {&(0x7f0000010200)="f8fffffff0ffffffffffffff00"/32, 0x20, 0x400}, {&(0x7f0000010300)="53595a4b414c4c45522020080000e780325132510000e780325100000000000041660069006c00650030000f00fc0000ffffffffffffffffffff0000ffffffff46494c453020202020202010000ee870325132510000e870325103000000000041660069006c00650031000f00100000ffffffffffffffffffff0000ffffffff46494c453120202020202020000ee870325132510000e870325105000a00000041660069006c00650032000f00140000ffffffffffffffffffff0000ffffffff46494c453220202020202020000ee870325132510000e870325106002823000041660069006c0065002e000f00d263006f006c0064000000ffff0000ffffffff46494c457e312020434f4c20000ee870325132510000e8703251070064000000", 0x120, 0x600}, {&(0x7f0000010500)="2e2020202020202020202010000ee870325132510000e87032510300000000002e2e20202020202020202010000ee870325132510000e870325100000000000041660069006c00650030000f00fc0000ffffffffffffffffffff0000ffffffff46494c453020202020202020000ee870325132510000e870325104001a040000", 0x80, 0x11400}, {&(0x7f0000010600)='syzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkal\x00\x00\x00\x00\x00\x00', 0x420, 0x21400}, {&(0x7f0000010b00)='syzkallers\x00'/32, 0x20, 0x31400}, {&(0x7f0000010c00)='syzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallersyzkallers\x00'/128, 0x80, 0x51400}], 0x0, &(0x7f0000010d00))

11:17:31 executing program 1:
perf_event_open(&(0x7f0000000080)={0x2, 0x80, 0xc2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0x0, 0xffffffffffffffff, 0x0)
r0 = openat$full(0xffffffffffffff9c, &(0x7f0000000140), 0x0, 0x0)
preadv(r0, &(0x7f0000000580)=[{&(0x7f0000000340)=""/244, 0xf4}, {0x0}, {0x0}, {&(0x7f00000006c0)=""/4096, 0x1000}], 0x4, 0x0, 0x0)

11:17:31 executing program 7:
perf_event_open(&(0x7f0000000080)={0x2, 0x80, 0xc2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0xffffffffffffffff, 0xffffffffffffffff, 0x2)
getpid()
ioctl$BLKTRACETEARDOWN(0xffffffffffffffff, 0x1276, 0x0)
ioctl$sock_SIOCGPGRP(0xffffffffffffffff, 0x8904, &(0x7f0000000300))
ioctl$TIOCGSID(0xffffffffffffffff, 0x5429, &(0x7f0000000340))
r0 = syz_genetlink_get_family_id$nl80211(&(0x7f0000000140), 0xffffffffffffffff)
sendmsg$NL80211_CMD_FRAME(0xffffffffffffffff, &(0x7f0000000000)={0x0, 0x0, &(0x7f00000001c0)={&(0x7f0000000500)=ANY=[@ANYBLOB="00010000", @ANYRES16=r0, @ANYBLOB="010000000000000000003b00000008000300", @ANYRES32, @ANYBLOB="e200330080800000080211000001080211000000505050505050"], 0x100}}, 0x0)
ioctl$sock_SIOCGPGRP(0xffffffffffffffff, 0x8904, &(0x7f00000004c0))
syz_io_uring_setup(0x2971, &(0x7f0000000200)={0x0, 0xdd89, 0x2, 0x2, 0x392}, &(0x7f0000ffc000/0x2000)=nil, &(0x7f0000ffb000/0x3000)=nil, &(0x7f0000000140), &(0x7f0000000400))
clone3(&(0x7f0000000440)={0x80202800, &(0x7f0000000000), &(0x7f0000000040), &(0x7f0000000500), {0x3f}, &(0x7f0000000180)=""/79, 0x4f, &(0x7f0000004c80)=""/102400, &(0x7f0000000100)}, 0x58)
socket$inet6_udplite(0xa, 0x2, 0x88)
socket$inet6_udplite(0xa, 0x2, 0x88)
openat$ttyS3(0xffffffffffffff9c, &(0x7f00000003c0), 0x40, 0x0)
syz_open_dev$tty20(0xc, 0x4, 0x0)
fcntl$notify(0xffffffffffffffff, 0x402, 0x2)
openat$ttyS3(0xffffffffffffff9c, &(0x7f0000000100), 0x88000, 0x0)
perf_event_open(&(0x7f0000000280)={0x1, 0x80, 0x0, 0x0, 0x0, 0x0, 0x0, 0x2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext={0x2}}, 0x0, 0xffffffffffffffff, 0xffffffffffffffff, 0x0)
clone3(&(0x7f0000004c00)={0xc0002100, 0x0, 0x0, 0x0, {}, 0x0, 0x0, 0x0, 0x0}, 0x58)

11:17:31 executing program 3:
syz_mount_image$ext4(0x0, &(0x7f0000000000)='./file0\x00', 0x0, 0x0, 0x0, 0x0, 0x0)
syz_mount_image$tmpfs(&(0x7f0000000640), &(0x7f0000000800)='./file0/file0\x00', 0x0, 0x0, 0x0, 0x0, &(0x7f0000000c80)={[{@mpol={'mpol', 0x3d, {'local', '=static'}}}]})

11:17:31 executing program 4:
keyctl$update(0x2, 0x0, &(0x7f0000000180)="150f3deb845ee64b64306eb7dfdcaafbb10a8b0401d9a65118dbac22d956bc80c0769e3d36d6c6b4eb47cfc8140332ec819e167870c2db3480774ed79bfea84bf29a2f8014eef84a20a575b46125a3", 0x4f)
add_key$fscrypt_v1(&(0x7f0000000200), &(0x7f0000000240)={'fscrypt:', @auto=[0x34, 0x0, 0x63, 0x39, 0x35, 0x0, 0x38, 0x3, 0x0, 0x32, 0x65, 0x0, 0x65, 0x38, 0x64]}, 0x0, 0x0, 0xfffffffffffffff9)
r0 = syz_init_net_socket$nl_generic(0x10, 0x3, 0x10)
sendmsg$NL802154_CMD_SET_MAX_FRAME_RETRIES(r0, &(0x7f0000000540)={&(0x7f0000000480), 0xc, &(0x7f0000000500)={&(0x7f00000004c0)={0x1c, 0x0, 0x800, 0x70bd26, 0x0, {}, [@NL802154_ATTR_MAX_FRAME_RETRIES={0x5, 0xf, 0x4}]}, 0x1c}, 0x1, 0x0, 0x0, 0x4000004}, 0x58004)
request_key(&(0x7f0000008f80)='asymmetric\x00', &(0x7f0000008fc0)={'syz', 0x1}, &(0x7f0000009000)='trusted\x00', 0x0)

11:17:31 executing program 5:
syz_open_dev$usbmon(&(0x7f00000001c0), 0x0, 0x8400)

11:17:31 executing program 6:
mlock2(&(0x7f0000ffa000/0x4000)=nil, 0x4000, 0x0)
munmap(&(0x7f0000ffb000/0x4000)=nil, 0x4000)
mremap(&(0x7f0000ffa000/0x1000)=nil, 0x1000, 0x4000, 0x0, &(0x7f0000ffa000/0x4000)=nil)

[   65.070005] audit: type=1400 audit(1663154251.063:6): avc:  denied  { execmem } for  pid=289 comm="syz-executor.1" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=process permissive=1
[   66.303902] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[   66.306951] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[   66.308567] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[   66.311419] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[   66.313417] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3
[   66.315626] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[   66.320370] Bluetooth: hci0: HCI_REQ-0x0c1a
[   66.370068] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1
[   66.372087] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9
[   66.373478] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9
[   66.375788] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4
[   66.377419] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3
[   66.378605] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2
[   66.386427] Bluetooth: hci2: HCI_REQ-0x0c1a
[   66.432631] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1
[   66.435138] Bluetooth: hci3: unexpected cc 0x0c03 length: 249 > 1
[   66.438724] Bluetooth: hci7: unexpected cc 0x0c03 length: 249 > 1
[   66.439972] Bluetooth: hci3: unexpected cc 0x1003 length: 249 > 9
[   66.441369] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9
[   66.442609] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9
[   66.444729] Bluetooth: hci3: unexpected cc 0x1001 length: 249 > 9
[   66.445776] Bluetooth: hci7: unexpected cc 0x1003 length: 249 > 9
[   66.451539] Bluetooth: hci7: unexpected cc 0x1001 length: 249 > 9
[   66.453521] Bluetooth: hci6: unexpected cc 0x0c03 length: 249 > 1
[   66.459243] Bluetooth: hci5: unexpected cc 0x0c03 length: 249 > 1
[   66.461358] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4
[   66.461567] Bluetooth: hci5: unexpected cc 0x1003 length: 249 > 9
[   66.462679] Bluetooth: hci3: unexpected cc 0x0c23 length: 249 > 4
[   66.463999] Bluetooth: hci5: unexpected cc 0x1001 length: 249 > 9
[   66.465647] Bluetooth: hci5: unexpected cc 0x0c23 length: 249 > 4
[   66.467493] Bluetooth: hci5: unexpected cc 0x0c25 length: 249 > 3
[   66.468806] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3
[   66.469864] Bluetooth: hci6: unexpected cc 0x1003 length: 249 > 9
[   66.471836] Bluetooth: hci3: unexpected cc 0x0c25 length: 249 > 3
[   66.472898] Bluetooth: hci7: unexpected cc 0x0c23 length: 249 > 4
[   66.474352] Bluetooth: hci5: unexpected cc 0x0c38 length: 249 > 2
[   66.478603] Bluetooth: hci5: HCI_REQ-0x0c1a
[   66.479696] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2
[   66.480805] Bluetooth: hci3: unexpected cc 0x0c38 length: 249 > 2
[   66.481876] Bluetooth: hci6: unexpected cc 0x1001 length: 249 > 9
[   66.491670] Bluetooth: hci7: unexpected cc 0x0c25 length: 249 > 3
[   66.493986] Bluetooth: hci7: unexpected cc 0x0c38 length: 249 > 2
[   66.498834] Bluetooth: hci1: HCI_REQ-0x0c1a
[   66.502445] Bluetooth: hci3: HCI_REQ-0x0c1a
[   66.515411] Bluetooth: hci7: HCI_REQ-0x0c1a
[   66.534455] Bluetooth: hci6: unexpected cc 0x0c23 length: 249 > 4
[   66.536709] Bluetooth: hci6: unexpected cc 0x0c25 length: 249 > 3
[   66.538098] Bluetooth: hci6: unexpected cc 0x0c38 length: 249 > 2
[   66.544441] Bluetooth: hci6: HCI_REQ-0x0c1a
[   66.563174] Bluetooth: hci4: unexpected cc 0x0c03 length: 249 > 1
[   66.565391] Bluetooth: hci4: unexpected cc 0x1003 length: 249 > 9
[   66.568138] Bluetooth: hci4: unexpected cc 0x1001 length: 249 > 9
[   66.573559] Bluetooth: hci4: unexpected cc 0x0c23 length: 249 > 4
[   66.576698] Bluetooth: hci4: unexpected cc 0x0c25 length: 249 > 3
[   66.577972] Bluetooth: hci4: unexpected cc 0x0c38 length: 249 > 2
[   66.588171] Bluetooth: hci4: HCI_REQ-0x0c1a
[   68.391742] Bluetooth: hci2: command 0x0409 tx timeout
[   68.392583] Bluetooth: hci0: command 0x0409 tx timeout
[   68.518425] Bluetooth: hci1: command 0x0409 tx timeout
[   68.519249] Bluetooth: hci3: command 0x0409 tx timeout
[   68.521182] Bluetooth: hci5: command 0x0409 tx timeout
[   68.582350] Bluetooth: hci7: command 0x0409 tx timeout
[   68.583327] Bluetooth: hci6: command 0x0409 tx timeout
[   68.647362] Bluetooth: hci4: command 0x0409 tx timeout
[   70.439334] Bluetooth: hci0: command 0x041b tx timeout
[   70.439853] Bluetooth: hci2: command 0x041b tx timeout
[   70.566399] Bluetooth: hci5: command 0x041b tx timeout
[   70.569794] Bluetooth: hci3: command 0x041b tx timeout
[   70.571019] Bluetooth: hci1: command 0x041b tx timeout
[   70.630396] Bluetooth: hci6: command 0x041b tx timeout
[   70.632186] Bluetooth: hci7: command 0x041b tx timeout
[   70.694480] Bluetooth: hci4: command 0x041b tx timeout
[   72.486375] Bluetooth: hci2: command 0x040f tx timeout
[   72.487258] Bluetooth: hci0: command 0x040f tx timeout
[   72.614672] Bluetooth: hci1: command 0x040f tx timeout
[   72.615951] Bluetooth: hci3: command 0x040f tx timeout
[   72.618366] Bluetooth: hci5: command 0x040f tx timeout
[   72.678405] Bluetooth: hci7: command 0x040f tx timeout
[   72.679212] Bluetooth: hci6: command 0x040f tx timeout
[   72.742605] Bluetooth: hci4: command 0x040f tx timeout
[   74.535329] Bluetooth: hci0: command 0x0419 tx timeout
[   74.535820] Bluetooth: hci2: command 0x0419 tx timeout
[   74.662577] Bluetooth: hci5: command 0x0419 tx timeout
[   74.663017] Bluetooth: hci3: command 0x0419 tx timeout
[   74.664918] Bluetooth: hci1: command 0x0419 tx timeout
[   74.727366] Bluetooth: hci6: command 0x0419 tx timeout
[   74.727802] Bluetooth: hci7: command 0x0419 tx timeout
[   74.791326] Bluetooth: hci4: command 0x0419 tx timeout
[  124.210320] audit: type=1400 audit(1663154310.203:7): avc:  denied  { open } for  pid=3832 comm="syz-executor.1" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=perf_event permissive=1
[  124.212145] audit: type=1400 audit(1663154310.204:8): avc:  denied  { kernel } for  pid=3832 comm="syz-executor.1" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=perf_event permissive=1
[  124.248501] ------------[ cut here ]------------
[  124.248535] 
[  124.248541] ======================================================
[  124.248547] WARNING: possible circular locking dependency detected
[  124.248553] 6.0.0-rc5-next-20220914 #1 Not tainted
[  124.248565] ------------------------------------------------------
[  124.248571] syz-executor.1/3833 is trying to acquire lock:
[  124.248583] ffffffff853fa878 ((console_sem).lock){....}-{2:2}, at: down_trylock+0xe/0x70
[  124.248645] 
[  124.248645] but task is already holding lock:
[  124.248650] ffff888010041c20 (&ctx->lock){....}-{2:2}, at: __perf_event_task_sched_out+0x53b/0x18d0
[  124.248700] 
[  124.248700] which lock already depends on the new lock.
[  124.248700] 
[  124.248705] 
[  124.248705] the existing dependency chain (in reverse order) is:
[  124.248711] 
[  124.248711] -> #3 (&ctx->lock){....}-{2:2}:
[  124.248737]        _raw_spin_lock+0x2a/0x40
[  124.248766]        __perf_event_task_sched_out+0x53b/0x18d0
[  124.248790]        __schedule+0xedd/0x2470
[  124.248809]        schedule+0xda/0x1b0
[  124.248827]        exit_to_user_mode_prepare+0x114/0x1a0
[  124.248863]        syscall_exit_to_user_mode+0x19/0x40
[  124.248894]        do_syscall_64+0x48/0x90
[  124.248919]        entry_SYSCALL_64_after_hwframe+0x63/0xcd
[  124.248950] 
[  124.248950] -> #2 (&rq->__lock){-.-.}-{2:2}:
[  124.248976]        _raw_spin_lock_nested+0x30/0x40
[  124.249004]        raw_spin_rq_lock_nested+0x1e/0x30
[  124.249026]        task_fork_fair+0x63/0x4d0
[  124.249057]        sched_cgroup_fork+0x3d0/0x540
[  124.249082]        copy_process+0x4183/0x6e20
[  124.249101]        kernel_clone+0xe7/0x890
[  124.249119]        user_mode_thread+0xad/0xf0
[  124.249138]        rest_init+0x24/0x250
[  124.249168]        arch_call_rest_init+0xf/0x14
[  124.249188]        start_kernel+0x4c1/0x4e6
[  124.249206]        secondary_startup_64_no_verify+0xe0/0xeb
[  124.249232] 
[  124.249232] -> #1 (&p->pi_lock){-.-.}-{2:2}:
[  124.249257]        _raw_spin_lock_irqsave+0x39/0x60
[  124.249285]        try_to_wake_up+0xab/0x1920
[  124.249310]        up+0x75/0xb0
[  124.249331]        __up_console_sem+0x6e/0x80
[  124.249359]        console_unlock+0x46a/0x590
[  124.249388]        do_con_write+0xc05/0x1d50
[  124.249407]        con_write+0x21/0x40
[  124.249425]        n_tty_write+0x4d4/0xfe0
[  124.249447]        file_tty_write.constprop.0+0x49c/0x8f0
[  124.249469]        vfs_write+0x9c3/0xd90
[  124.249501]        ksys_write+0x127/0x250
[  124.249531]        do_syscall_64+0x3b/0x90
[  124.249555]        entry_SYSCALL_64_after_hwframe+0x63/0xcd
[  124.249587] 
[  124.249587] -> #0 ((console_sem).lock){....}-{2:2}:
[  124.249613]        __lock_acquire+0x2a02/0x5e70
[  124.249643]        lock_acquire+0x1a2/0x530
[  124.249672]        _raw_spin_lock_irqsave+0x39/0x60
[  124.249700]        down_trylock+0xe/0x70
[  124.249723]        __down_trylock_console_sem+0x3b/0xd0
[  124.249752]        vprintk_emit+0x16b/0x560
[  124.249782]        vprintk+0x84/0xa0
[  124.249812]        _printk+0xba/0xf1
[  124.249842]        report_bug.cold+0x72/0xab
[  124.249865]        handle_bug+0x3c/0x70
[  124.249889]        exc_invalid_op+0x14/0x50
[  124.249914]        asm_exc_invalid_op+0x16/0x20
[  124.249943]        group_sched_out.part.0+0x2c7/0x460
[  124.249963]        ctx_sched_out+0x8f1/0xc10
[  124.249981]        __perf_event_task_sched_out+0x6d0/0x18d0
[  124.250004]        __schedule+0xedd/0x2470
[  124.250023]        schedule+0xda/0x1b0
[  124.250041]        exit_to_user_mode_prepare+0x114/0x1a0
[  124.250075]        syscall_exit_to_user_mode+0x19/0x40
[  124.250106]        do_syscall_64+0x48/0x90
[  124.250130]        entry_SYSCALL_64_after_hwframe+0x63/0xcd
[  124.250162] 
[  124.250162] other info that might help us debug this:
[  124.250162] 
[  124.250166] Chain exists of:
[  124.250166]   (console_sem).lock --> &rq->__lock --> &ctx->lock
[  124.250166] 
[  124.250194]  Possible unsafe locking scenario:
[  124.250194] 
[  124.250199]        CPU0                    CPU1
[  124.250203]        ----                    ----
[  124.250207]   lock(&ctx->lock);
[  124.250217]                                lock(&rq->__lock);
[  124.250229]                                lock(&ctx->lock);
[  124.250241]   lock((console_sem).lock);
[  124.250252] 
[  124.250252]  *** DEADLOCK ***
[  124.250252] 
[  124.250255] 2 locks held by syz-executor.1/3833:
[  124.250268]  #0: ffff88806ce37cd8 (&rq->__lock){-.-.}-{2:2}, at: __schedule+0x1cf/0x2470
[  124.250318]  #1: ffff888010041c20 (&ctx->lock){....}-{2:2}, at: __perf_event_task_sched_out+0x53b/0x18d0
[  124.250370] 
[  124.250370] stack backtrace:
[  124.250375] CPU: 0 PID: 3833 Comm: syz-executor.1 Not tainted 6.0.0-rc5-next-20220914 #1
[  124.250399] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
[  124.250413] Call Trace:
[  124.250418]  <TASK>
[  124.250426]  dump_stack_lvl+0x8b/0xb3
[  124.250453]  check_noncircular+0x263/0x2e0
[  124.250483]  ? format_decode+0x26c/0xb50
[  124.250510]  ? print_circular_bug+0x450/0x450
[  124.250541]  ? enable_ptr_key_workfn+0x20/0x20
[  124.250569]  ? format_decode+0x26c/0xb50
[  124.250598]  ? alloc_chain_hlocks+0x1ec/0x5a0
[  124.250631]  __lock_acquire+0x2a02/0x5e70
[  124.250671]  ? lockdep_hardirqs_on_prepare+0x410/0x410
[  124.250712]  lock_acquire+0x1a2/0x530
[  124.250743]  ? down_trylock+0xe/0x70
[  124.250770]  ? rcu_read_unlock+0x40/0x40
[  124.250809]  ? vprintk+0x84/0xa0
[  124.250842]  _raw_spin_lock_irqsave+0x39/0x60
[  124.250871]  ? down_trylock+0xe/0x70
[  124.250896]  down_trylock+0xe/0x70
[  124.250921]  ? vprintk+0x84/0xa0
[  124.250952]  __down_trylock_console_sem+0x3b/0xd0
[  124.250984]  vprintk_emit+0x16b/0x560
[  124.251019]  vprintk+0x84/0xa0
[  124.251051]  _printk+0xba/0xf1
[  124.251083]  ? record_print_text.cold+0x16/0x16
[  124.251124]  ? report_bug.cold+0x66/0xab
[  124.251150]  ? group_sched_out.part.0+0x2c7/0x460
[  124.251172]  report_bug.cold+0x72/0xab
[  124.251200]  handle_bug+0x3c/0x70
[  124.251226]  exc_invalid_op+0x14/0x50
[  124.251253]  asm_exc_invalid_op+0x16/0x20
[  124.251284] RIP: 0010:group_sched_out.part.0+0x2c7/0x460
[  124.251309] Code: 5e 41 5f e9 3b b7 ef ff e8 36 b7 ef ff 65 8b 1d ab 15 ac 7e 31 ff 89 de e8 d6 b3 ef ff 85 db 0f 84 8a 00 00 00 e8 19 b7 ef ff <0f> 0b e9 a5 fe ff ff e8 0d b7 ef ff 48 8d 7d 10 48 b8 00 00 00 00
[  124.251330] RSP: 0018:ffff888018bdfc48 EFLAGS: 00010006
[  124.251347] RAX: 0000000040000002 RBX: 0000000000000000 RCX: 0000000000000000
[  124.251361] RDX: ffff88801c295040 RSI: ffffffff81566027 RDI: 0000000000000005
[  124.251376] RBP: ffff8880086605c8 R08: 0000000000000005 R09: 0000000000000001
[  124.251390] R10: 0000000000000000 R11: ffffffff865ac01b R12: ffff888010041c00
[  124.251405] R13: ffff88806ce3d100 R14: ffffffff8547c660 R15: 0000000000000002
[  124.251426]  ? group_sched_out.part.0+0x2c7/0x460
[  124.251451]  ? group_sched_out.part.0+0x2c7/0x460
[  124.251475]  ctx_sched_out+0x8f1/0xc10
[  124.251499]  __perf_event_task_sched_out+0x6d0/0x18d0
[  124.251528]  ? lock_is_held_type+0xd7/0x130
[  124.251563]  ? __perf_cgroup_move+0x160/0x160
[  124.251588]  ? set_next_entity+0x304/0x550
[  124.251622]  ? update_curr+0x267/0x740
[  124.251656]  ? lock_is_held_type+0xd7/0x130
[  124.251690]  __schedule+0xedd/0x2470
[  124.251715]  ? io_schedule_timeout+0x150/0x150
[  124.251739]  ? rcu_read_lock_sched_held+0x3e/0x80
[  124.251776]  schedule+0xda/0x1b0
[  124.251798]  exit_to_user_mode_prepare+0x114/0x1a0
[  124.251835]  syscall_exit_to_user_mode+0x19/0x40
[  124.251868]  do_syscall_64+0x48/0x90
[  124.251904]  entry_SYSCALL_64_after_hwframe+0x63/0xcd
[  124.251936] RIP: 0033:0x7f80b0bc0b19
[  124.251952] Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 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 bc ff ff ff f7 d8 64 89 01 48
[  124.251973] RSP: 002b:00007f80ae136218 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[  124.251994] RAX: 0000000000000001 RBX: 00007f80b0cd3f68 RCX: 00007f80b0bc0b19
[  124.252008] RDX: 00000000000f4240 RSI: 0000000000000081 RDI: 00007f80b0cd3f6c
[  124.252023] RBP: 00007f80b0cd3f60 R08: 000000000000000e R09: 0000000000000000
[  124.252036] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f80b0cd3f6c
[  124.252050] R13: 00007fff91bb27af R14: 00007f80ae136300 R15: 0000000000022000
[  124.252075]  </TASK>
[  124.351390] WARNING: CPU: 0 PID: 3833 at kernel/events/core.c:2309 group_sched_out.part.0+0x2c7/0x460
[  124.352593] Modules linked in:
[  124.353029] CPU: 0 PID: 3833 Comm: syz-executor.1 Not tainted 6.0.0-rc5-next-20220914 #1
[  124.354067] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
[  124.355511] RIP: 0010:group_sched_out.part.0+0x2c7/0x460
[  124.356241] Code: 5e 41 5f e9 3b b7 ef ff e8 36 b7 ef ff 65 8b 1d ab 15 ac 7e 31 ff 89 de e8 d6 b3 ef ff 85 db 0f 84 8a 00 00 00 e8 19 b7 ef ff <0f> 0b e9 a5 fe ff ff e8 0d b7 ef ff 48 8d 7d 10 48 b8 00 00 00 00
[  124.358568] RSP: 0018:ffff888018bdfc48 EFLAGS: 00010006
[  124.359258] RAX: 0000000040000002 RBX: 0000000000000000 RCX: 0000000000000000
[  124.360202] RDX: ffff88801c295040 RSI: ffffffff81566027 RDI: 0000000000000005
[  124.361114] RBP: ffff8880086605c8 R08: 0000000000000005 R09: 0000000000000001
[  124.362022] R10: 0000000000000000 R11: ffffffff865ac01b R12: ffff888010041c00
[  124.362886] R13: ffff88806ce3d100 R14: ffffffff8547c660 R15: 0000000000000002
[  124.363753] FS:  00007f80ae136700(0000) GS:ffff88806ce00000(0000) knlGS:0000000000000000
[  124.364794] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  124.365550] CR2: 00007ffacb900028 CR3: 0000000017408000 CR4: 0000000000350ef0
[  124.366434] Call Trace:
[  124.366754]  <TASK>
[  124.367057]  ctx_sched_out+0x8f1/0xc10
[  124.367575]  __perf_event_task_sched_out+0x6d0/0x18d0
[  124.368247]  ? lock_is_held_type+0xd7/0x130
[  124.368819]  ? __perf_cgroup_move+0x160/0x160
[  124.369414]  ? set_next_entity+0x304/0x550
[  124.369958]  ? update_curr+0x267/0x740
[  124.370454]  ? lock_is_held_type+0xd7/0x130
[  124.370992]  __schedule+0xedd/0x2470
[  124.371459]  ? io_schedule_timeout+0x150/0x150
[  124.372054]  ? rcu_read_lock_sched_held+0x3e/0x80
[  124.372670]  schedule+0xda/0x1b0
[  124.373096]  exit_to_user_mode_prepare+0x114/0x1a0
[  124.373718]  syscall_exit_to_user_mode+0x19/0x40
[  124.374317]  do_syscall_64+0x48/0x90
[  124.374788]  entry_SYSCALL_64_after_hwframe+0x63/0xcd
[  124.375434] RIP: 0033:0x7f80b0bc0b19
[  124.375900] Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 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 bc ff ff ff f7 d8 64 89 01 48
[  124.378147] RSP: 002b:00007f80ae136218 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[  124.379112] RAX: 0000000000000001 RBX: 00007f80b0cd3f68 RCX: 00007f80b0bc0b19
[  124.380036] RDX: 00000000000f4240 RSI: 0000000000000081 RDI: 00007f80b0cd3f6c
[  124.380967] RBP: 00007f80b0cd3f60 R08: 000000000000000e R09: 0000000000000000
[  124.381853] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f80b0cd3f6c
[  124.382706] R13: 00007fff91bb27af R14: 00007f80ae136300 R15: 0000000000022000
[  124.383577]  </TASK>
[  124.383869] irq event stamp: 3238
[  124.384325] hardirqs last  enabled at (3237): [<ffffffff8133ffc9>] exit_to_user_mode_prepare+0x109/0x1a0
[  124.385540] hardirqs last disabled at (3238): [<ffffffff8424bcf5>] __schedule+0x1225/0x2470
[  124.386592] softirqs last  enabled at (3076): [<ffffffff8117063b>] __irq_exit_rcu+0x11b/0x180
[  124.387656] softirqs last disabled at (3047): [<ffffffff8117063b>] __irq_exit_rcu+0x11b/0x180
[  124.388765] ---[ end trace 0000000000000000 ]---
11:18:30 executing program 1:
perf_event_open(&(0x7f0000000080)={0x2, 0x80, 0xc2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0x0, 0xffffffffffffffff, 0x0)
r0 = openat$full(0xffffffffffffff9c, &(0x7f0000000140), 0x0, 0x0)
preadv(r0, &(0x7f0000000580)=[{&(0x7f0000000340)=""/244, 0xf4}, {0x0}, {0x0}, {&(0x7f00000006c0)=""/4096, 0x1000}], 0x4, 0x0, 0x0)

11:18:31 executing program 1:
perf_event_open(&(0x7f0000000080)={0x2, 0x80, 0xc2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0x0, 0xffffffffffffffff, 0x0)
r0 = openat$full(0xffffffffffffff9c, &(0x7f0000000140), 0x0, 0x0)
preadv(r0, &(0x7f0000000580)=[{&(0x7f0000000340)=""/244, 0xf4}, {0x0}, {0x0}, {&(0x7f00000006c0)=""/4096, 0x1000}], 0x4, 0x0, 0x0)

11:18:31 executing program 1:
perf_event_open(&(0x7f0000000080)={0x2, 0x80, 0xc2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0x0, 0xffffffffffffffff, 0x0)
r0 = openat$full(0xffffffffffffff9c, &(0x7f0000000140), 0x0, 0x0)
preadv(r0, &(0x7f0000000580)=[{&(0x7f0000000340)=""/244, 0xf4}, {0x0}, {0x0}, {&(0x7f00000006c0)=""/4096, 0x1000}], 0x4, 0x0, 0x0)

11:18:31 executing program 1:
epoll_create(0x4)
epoll_create1(0x0)
openat$procfs(0xffffffffffffff9c, &(0x7f0000000700)='/proc/asound/seq/clients\x00', 0x0, 0x0)

11:18:31 executing program 1:
epoll_create(0x4)
epoll_create1(0x0)
openat$procfs(0xffffffffffffff9c, &(0x7f0000000700)='/proc/asound/seq/clients\x00', 0x0, 0x0)

11:18:31 executing program 1:
epoll_create(0x4)
epoll_create1(0x0)
openat$procfs(0xffffffffffffff9c, &(0x7f0000000700)='/proc/asound/seq/clients\x00', 0x0, 0x0)

11:18:31 executing program 1:
epoll_create(0x4)
epoll_create1(0x0)
openat$procfs(0xffffffffffffff9c, &(0x7f0000000700)='/proc/asound/seq/clients\x00', 0x0, 0x0)

11:18:31 executing program 1:
epoll_create(0x4)
epoll_create1(0x0)
openat$procfs(0xffffffffffffff9c, &(0x7f0000000700)='/proc/asound/seq/clients\x00', 0x0, 0x0)

[  127.849910] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1
[  127.856170] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9
[  127.857607] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9
[  127.859533] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4
[  127.860946] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3
[  127.862816] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2
[  127.865620] Bluetooth: hci1: HCI_REQ-0x0c1a
[  128.020533] Bluetooth: hci6: unexpected cc 0x0c03 length: 249 > 1
[  128.021824] Bluetooth: hci6: unexpected cc 0x1003 length: 249 > 9
[  128.023106] Bluetooth: hci6: unexpected cc 0x1001 length: 249 > 9
[  128.024928] Bluetooth: hci6: unexpected cc 0x0c23 length: 249 > 4
[  128.032101] Bluetooth: hci6: unexpected cc 0x0c25 length: 249 > 3
[  128.033396] Bluetooth: hci6: unexpected cc 0x0c38 length: 249 > 2
[  128.037350] Bluetooth: hci6: HCI_REQ-0x0c1a
[  129.894339] Bluetooth: hci1: command 0x0409 tx timeout
[  130.022298] Bluetooth: hci3: Opcode 0x c03 failed: -110
[  130.022340] Bluetooth: hci7: Opcode 0x c03 failed: -110
[  130.023737] Bluetooth: hci5: Opcode 0x c03 failed: -110
[  130.024579] Bluetooth: hci4: Opcode 0x c03 failed: -110
[  130.025366] Bluetooth: hci2: Opcode 0x c03 failed: -110
[  130.087295] Bluetooth: hci6: command 0x0409 tx timeout
[  131.942399] Bluetooth: hci1: command 0x041b tx timeout
[  132.134351] Bluetooth: hci6: command 0x041b tx timeout
[  132.339550] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1
[  132.341472] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9
[  132.343048] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9
[  132.345887] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4
[  132.347480] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3
[  132.348836] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2
[  132.352090] Bluetooth: hci2: HCI_REQ-0x0c1a
[  132.656521] Bluetooth: hci5: unexpected cc 0x0c03 length: 249 > 1
[  132.658574] Bluetooth: hci5: unexpected cc 0x1003 length: 249 > 9
[  132.662522] Bluetooth: hci5: unexpected cc 0x1001 length: 249 > 9
[  132.664468] Bluetooth: hci5: unexpected cc 0x0c23 length: 249 > 4
[  132.666063] Bluetooth: hci5: unexpected cc 0x0c25 length: 249 > 3
[  132.667186] Bluetooth: hci5: unexpected cc 0x0c38 length: 249 > 2
[  132.673353] Bluetooth: hci5: HCI_REQ-0x0c1a
[  133.990430] Bluetooth: hci1: command 0x040f tx timeout
[  134.182394] Bluetooth: hci6: command 0x040f tx timeout

VM DIAGNOSIS:
11:18:30  Registers:
info registers vcpu 0
RAX=dffffc0000000060 RBX=00000000000003fd RCX=0000000000000000 RDX=00000000000003fd
RSI=ffffffff822b246c RDI=ffffffff87641b60 RBP=ffffffff87641b20 RSP=ffff888018bdf640
R8 =0000000000000004 R9 =0000000000000010 R10=0000000000000010 R11=0000000000000001
R12=0000000000002710 R13=0000000000000020 R14=fffffbfff0ec83bb R15=dffffc0000000000
RIP=ffffffff822b24c1 RFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0
ES =0000 0000000000000000 00000000 00000000
CS =0010 0000000000000000 ffffffff 00a09b00 DPL=0 CS64 [-RA]
SS =0018 0000000000000000 ffffffff 00c09300 DPL=0 DS   [-WA]
DS =0000 0000000000000000 00000000 00000000
FS =0000 00007f80ae136700 00000000 00000000
GS =0000 ffff88806ce00000 00000000 00000000
LDT=0000 fffffe0000000000 00000000 00000000
TR =0040 fffffe0000003000 00004087 00008b00 DPL=0 TSS64-busy
GDT=     fffffe0000001000 0000007f
IDT=     fffffe0000000000 00000fff
CR0=80050033 CR2=00007ffacb900028 CR3=0000000017408000 CR4=00350ef0
DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 
DR6=00000000ffff0ff0 DR7=0000000000000400
EFER=0000000000000d01
FCW=037f FSW=0000 [ST=0] FTW=00 MXCSR=00001f80
FPR0=0000000000000000 0000 FPR1=0000000000000000 0000
FPR2=0000000000000000 0000 FPR3=0000000000000000 0000
FPR4=0000000000000000 0000 FPR5=0000000000000000 0000
FPR6=0000000000000000 0000 FPR7=0000000000000000 0000
YMM00=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM01=0000000000000000 0000000000000000 00007f80b0ca77c0 00007f80b0ca77c8
YMM02=0000000000000000 0000000000000000 00007f80b0ca77e0 00007f80b0ca77c0
YMM03=0000000000000000 0000000000000000 00007f80b0ca77c8 00007f80b0ca77c0
YMM04=0000000000000000 0000000000000000 ffffffffffffffff ffffffff00000000
YMM05=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM06=0000000000000000 0000000000000000 0000000000000000 000000524f525245
YMM07=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM08=0000000000000000 0000000000000000 0000000000000000 00524f5252450040
YMM09=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM10=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM11=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM12=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM13=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM14=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM15=0000000000000000 0000000000000000 0000000000000000 0000000000000000
info registers vcpu 1
RAX=ffff88801b1d8001 RBX=0000000000000001 RCX=0000000000000001 RDX=ffff88801b1d7f01
RSI=ffff88801b1d7f48 RDI=ffff88801b1d7f48 RBP=ffff88801b1d7f48 RSP=ffff88801b1d72f8
R8 =ffffffff8623c6cc R9 =ffffffff8623c6d0 R10=ffffed100363ae7d R11=ffff88801b1d73c0
R12=ffff88801b1d73c1 R13=ffff88801b1d73e0 R14=ffff88801b1d7380 R15=0000000000000001
RIP=ffffffff8111ac00 RFL=00000202 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0
ES =0000 0000000000000000 00000000 00000000
CS =0010 0000000000000000 ffffffff 00a09b00 DPL=0 CS64 [-RA]
SS =0018 0000000000000000 ffffffff 00c09300 DPL=0 DS   [-WA]
DS =0000 0000000000000000 00000000 00000000
FS =0000 0000000000000000 00000000 00000000
GS =0000 ffff88806cf00000 00000000 00000000
LDT=0000 fffffe0000000000 00000000 00000000
TR =0040 fffffe000004a000 00004087 00008b00 DPL=0 TSS64-busy
GDT=     fffffe0000048000 0000007f
IDT=     fffffe0000000000 00000fff
CR0=80050033 CR2=00007fa5805d2028 CR3=000000003d796000 CR4=00350ee0
DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 
DR6=00000000ffff0ff0 DR7=0000000000000400
EFER=0000000000000d01
FCW=037f FSW=0000 [ST=0] FTW=00 MXCSR=00001f80
FPR0=0000000000000000 0000 FPR1=0000000000000000 0000
FPR2=0000000000000000 0000 FPR3=0000000000000000 0000
FPR4=0000000000000000 0000 FPR5=0000000000000000 0000
FPR6=0000000000000000 0000 FPR7=0000000000000000 0000
YMM00=0000000000000000 0000000000000000 756e696c2d34365f 3638782f62696c2f
YMM01=0000000000000000 0000000000000000 6f732e616d7a6c62 696c2f756e672d78
YMM02=0000000000000000 0000000000000000 00352e6f732e616d 7a6c62696c2f756e
YMM03=0000000000000000 0000000000000000 672d78756e696c2d 34365f3638782f62
YMM04=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM05=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM06=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM07=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM08=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM09=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM10=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM11=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM12=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM13=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM14=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM15=0000000000000000 0000000000000000 0000000000000000 0000000000000000