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]
[ 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]
[ 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]
[ 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]
[ 124.383869] irq event stamp: 3238
[ 124.384325] hardirqs last enabled at (3237): [] exit_to_user_mode_prepare+0x109/0x1a0
[ 124.385540] hardirqs last disabled at (3238): [] __schedule+0x1225/0x2470
[ 124.386592] softirqs last enabled at (3076): [] __irq_exit_rcu+0x11b/0x180
[ 124.387656] softirqs last disabled at (3047): [] __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