Warning: Permanently added '[localhost]:62919' (ECDSA) to the list of known hosts.
2022/09/15 10:50:35 fuzzer started
2022/09/15 10:50:35 dialing manager at localhost:36559
2022/09/15 10:50:35 checking machine...
2022/09/15 10:50:35 checking revisions...
syzkaller login: [ 35.646917] kmemleak: Automatic memory scanning thread ended
2022/09/15 10:50:35 testing simple program...
[ 35.727739] cgroup: Unknown subsys name 'net'
[ 35.834397] cgroup: Unknown subsys name 'rlimit'
executing program
executing program
executing program
executing program
[ 49.285789] audit: type=1400 audit(1663239049.610:6): avc: denied { execmem } for pid=284 comm="syz-executor.0" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=process permissive=1
[ 50.388728] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[ 50.391717] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[ 50.392989] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[ 50.397030] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[ 50.400022] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3
[ 50.401450] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[ 50.408303] Bluetooth: hci0: HCI_REQ-0x0c1a
executing program
[ 52.468841] Bluetooth: hci0: command 0x0409 tx timeout
executing program
[ 54.516267] Bluetooth: hci0: command 0x041b tx timeout
executing program
[ 56.564286] Bluetooth: hci0: command 0x040f tx timeout
[ 58.613255] Bluetooth: hci0: command 0x0419 tx timeout
executing program
executing program
executing program
executing program
executing program
2022/09/15 10:51:11 building call list...
[ 74.204898] audit: type=1400 audit(1663239074.529:7): avc: denied { create } for pid=264 comm="syz-fuzzer" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=dccp_socket permissive=1
executing program
2022/09/15 10:51:17 syscalls: 2215
2022/09/15 10:51:17 code coverage: enabled
2022/09/15 10:51:17 comparison tracing: enabled
2022/09/15 10:51:17 extra coverage: enabled
2022/09/15 10:51:17 setuid sandbox: enabled
2022/09/15 10:51:17 namespace sandbox: enabled
2022/09/15 10:51:17 Android sandbox: enabled
2022/09/15 10:51:17 fault injection: enabled
2022/09/15 10:51:17 leak checking: enabled
2022/09/15 10:51:17 net packet injection: enabled
2022/09/15 10:51:17 net device setup: enabled
2022/09/15 10:51:17 concurrency sanitizer: /sys/kernel/debug/kcsan does not exist
2022/09/15 10:51:17 devlink PCI setup: PCI device 0000:00:10.0 is not available
2022/09/15 10:51:17 USB emulation: enabled
2022/09/15 10:51:17 hci packet injection: enabled
2022/09/15 10:51:17 wifi device emulation: failed to parse kernel version (6.0.0-rc5-next-20220915 )
2022/09/15 10:51:17 802.15.4 emulation: enabled
2022/09/15 10:51:17 fetching corpus: 0, signal 0/0 (executing program)
2022/09/15 10:51:17 fetching corpus: 0, signal 0/0 (executing program)
2022/09/15 10:51:18 starting 8 fuzzer processes
10:51:18 executing program 0:
shmat(0x0, &(0x7f0000ff9000/0x1000)=nil, 0x4000)
mlock2(&(0x7f0000ff9000/0x4000)=nil, 0x4000, 0x0)
madvise(&(0x7f0000ff9000/0x3000)=nil, 0x3000, 0x2)
shmat(0x0, &(0x7f0000ffa000/0x3000)=nil, 0x7000)
10:51:18 executing program 1:
pidfd_getfd(0xffffffffffffffff, 0xffffffffffffffff, 0x0)
10:51:18 executing program 2:
r0 = socket$nl_xfrm(0x10, 0x3, 0x6)
sendmsg$nl_xfrm(r0, &(0x7f0000000a00)={0x0, 0x0, &(0x7f00000009c0)={&(0x7f0000000a40)=@polexpire={0xcc, 0x1b, 0x1, 0x0, 0x0, {{{@in=@multicast1, @in, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xee00}}}, [@sec_ctx={0xc, 0x8, {0x8}}]}, 0xcc}}, 0x0)
10:51:18 executing program 3:
r0 = openat$full(0xffffffffffffff9c, &(0x7f0000000780), 0x0, 0x0)
read$rfkill(r0, &(0x7f0000000000), 0x4df1548854c15113)
10:51:18 executing program 4:
r0 = socket$inet6_icmp_raw(0xa, 0x3, 0x3a)
ioctl$sock_SIOCETHTOOL(r0, 0x8946, &(0x7f0000000040)={'syz_tun\x00', &(0x7f0000000000)=@ethtool_channels={0x4a}})
10:51:19 executing program 5:
r0 = syz_open_dev$tty1(0xc, 0x4, 0x1)
ioctl$TCSETSW2(r0, 0x4bfa, &(0x7f0000000440)={0x0, 0x0, 0x0, 0x0, 0x0, "1047c359a4f1acb11cad4ebfd27f6921c592f1"})
10:51:19 executing program 6:
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 = 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_bp={0x0, 0xb}, 0x45534}, 0x0, 0xffffffffffffffff, 0xffffffffffffffff, 0x0)
socket$inet6_udp(0xa, 0x2, 0x0)
connect$inet6(0xffffffffffffffff, 0x0, 0x0)
vmsplice(r0, &(0x7f0000000040)=[{&(0x7f0000000100)="047aaa7b8edc7c225166ab148bfe9b97028709f17c3490d35b4a636b3c61bd0fa309a6e04a3a12b0c58d2fff35f31d8f5e69170ff4363a0af4243597605794e18714af", 0x43}], 0x1, 0x8)
r1 = openat(0xffffffffffffff9c, &(0x7f0000000100)='./file1\x00', 0x101042, 0x0)
open_by_handle_at(r1, &(0x7f0000000140)=@ceph_nfs_confh={0x10, 0x2, {0x28}}, 0x600)
10:51:19 executing program 7:
restart_syscall()
[ 80.014684] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[ 80.017846] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[ 80.019662] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[ 80.023403] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[ 80.025622] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3
[ 80.027287] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[ 80.032287] Bluetooth: hci0: HCI_REQ-0x0c1a
[ 80.092567] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1
[ 80.096867] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1
[ 80.098657] Bluetooth: hci3: unexpected cc 0x0c03 length: 249 > 1
[ 80.100027] Bluetooth: hci4: unexpected cc 0x0c03 length: 249 > 1
[ 80.101643] Bluetooth: hci6: unexpected cc 0x0c03 length: 249 > 1
[ 80.103647] Bluetooth: hci5: unexpected cc 0x0c03 length: 249 > 1
[ 80.105238] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9
[ 80.106435] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9
[ 80.107793] Bluetooth: hci6: unexpected cc 0x1003 length: 249 > 9
[ 80.109046] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9
[ 80.110113] Bluetooth: hci5: unexpected cc 0x1003 length: 249 > 9
[ 80.111343] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9
[ 80.112563] Bluetooth: hci6: unexpected cc 0x1001 length: 249 > 9
[ 80.114601] Bluetooth: hci5: unexpected cc 0x1001 length: 249 > 9
[ 80.121154] Bluetooth: hci3: unexpected cc 0x1003 length: 249 > 9
[ 80.122351] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4
[ 80.124044] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4
[ 80.125756] Bluetooth: hci6: unexpected cc 0x0c23 length: 249 > 4
[ 80.126844] Bluetooth: hci5: unexpected cc 0x0c23 length: 249 > 4
[ 80.128089] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3
[ 80.129665] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3
[ 80.130851] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2
[ 80.131968] Bluetooth: hci6: unexpected cc 0x0c25 length: 249 > 3
[ 80.133049] Bluetooth: hci5: unexpected cc 0x0c25 length: 249 > 3
[ 80.134263] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2
[ 80.135412] Bluetooth: hci3: unexpected cc 0x1001 length: 249 > 9
[ 80.136885] Bluetooth: hci6: unexpected cc 0x0c38 length: 249 > 2
[ 80.138361] Bluetooth: hci5: unexpected cc 0x0c38 length: 249 > 2
[ 80.142597] Bluetooth: hci2: HCI_REQ-0x0c1a
[ 80.143463] Bluetooth: hci4: unexpected cc 0x1003 length: 249 > 9
[ 80.151884] Bluetooth: hci4: unexpected cc 0x1001 length: 249 > 9
[ 80.153097] Bluetooth: hci3: unexpected cc 0x0c23 length: 249 > 4
[ 80.156313] Bluetooth: hci3: unexpected cc 0x0c25 length: 249 > 3
[ 80.157570] Bluetooth: hci3: unexpected cc 0x0c38 length: 249 > 2
[ 80.158610] Bluetooth: hci4: unexpected cc 0x0c23 length: 249 > 4
[ 80.160568] Bluetooth: hci4: unexpected cc 0x0c25 length: 249 > 3
[ 80.163291] Bluetooth: hci3: HCI_REQ-0x0c1a
[ 80.168683] Bluetooth: hci5: HCI_REQ-0x0c1a
[ 80.168839] Bluetooth: hci1: HCI_REQ-0x0c1a
[ 80.177378] Bluetooth: hci6: HCI_REQ-0x0c1a
[ 80.219096] Bluetooth: hci4: unexpected cc 0x0c38 length: 249 > 2
[ 80.237315] Bluetooth: hci4: HCI_REQ-0x0c1a
[ 82.100322] Bluetooth: hci0: command 0x0409 tx timeout
[ 82.165371] Bluetooth: hci7: Opcode 0x c03 failed: -110
[ 82.228406] Bluetooth: hci1: command 0x0409 tx timeout
[ 82.229391] Bluetooth: hci6: command 0x0409 tx timeout
[ 82.229572] Bluetooth: hci5: command 0x0409 tx timeout
[ 82.229652] Bluetooth: hci3: command 0x0409 tx timeout
[ 82.230424] Bluetooth: hci2: command 0x0409 tx timeout
[ 82.292410] Bluetooth: hci4: command 0x0409 tx timeout
[ 84.148252] Bluetooth: hci0: command 0x041b tx timeout
[ 84.276551] Bluetooth: hci2: command 0x041b tx timeout
[ 84.277287] Bluetooth: hci3: command 0x041b tx timeout
[ 84.277932] Bluetooth: hci1: command 0x041b tx timeout
[ 84.278612] Bluetooth: hci5: command 0x041b tx timeout
[ 84.279031] Bluetooth: hci6: command 0x041b tx timeout
[ 84.341261] Bluetooth: hci4: command 0x041b tx timeout
[ 85.073683] Bluetooth: hci7: unexpected cc 0x0c03 length: 249 > 1
[ 85.075144] Bluetooth: hci7: unexpected cc 0x1003 length: 249 > 9
[ 85.075995] Bluetooth: hci7: unexpected cc 0x1001 length: 249 > 9
[ 85.095360] Bluetooth: hci7: unexpected cc 0x0c23 length: 249 > 4
[ 85.097894] Bluetooth: hci7: unexpected cc 0x0c25 length: 249 > 3
[ 85.099412] Bluetooth: hci7: unexpected cc 0x0c38 length: 249 > 2
[ 85.104230] Bluetooth: hci7: HCI_REQ-0x0c1a
[ 86.197244] Bluetooth: hci0: command 0x040f tx timeout
[ 86.324348] Bluetooth: hci6: command 0x040f tx timeout
[ 86.325228] Bluetooth: hci2: command 0x040f tx timeout
[ 86.326099] Bluetooth: hci5: command 0x040f tx timeout
[ 86.327267] Bluetooth: hci1: command 0x040f tx timeout
[ 86.327980] Bluetooth: hci3: command 0x040f tx timeout
[ 86.388247] Bluetooth: hci4: command 0x040f tx timeout
[ 87.156261] Bluetooth: hci7: command 0x0409 tx timeout
[ 88.244274] Bluetooth: hci0: command 0x0419 tx timeout
[ 88.372276] Bluetooth: hci3: command 0x0419 tx timeout
[ 88.372776] Bluetooth: hci1: command 0x0419 tx timeout
[ 88.373222] Bluetooth: hci5: command 0x0419 tx timeout
[ 88.373631] Bluetooth: hci2: command 0x0419 tx timeout
[ 88.374035] Bluetooth: hci6: command 0x0419 tx timeout
[ 88.436206] Bluetooth: hci4: command 0x0419 tx timeout
[ 89.204243] Bluetooth: hci7: command 0x041b tx timeout
[ 91.252217] Bluetooth: hci7: command 0x040f tx timeout
[ 93.300229] Bluetooth: hci7: command 0x0419 tx timeout
10:52:18 executing program 2:
r0 = socket$nl_xfrm(0x10, 0x3, 0x6)
sendmsg$nl_xfrm(r0, &(0x7f0000000a00)={0x0, 0x0, &(0x7f00000009c0)={&(0x7f0000000a40)=@polexpire={0xcc, 0x1b, 0x1, 0x0, 0x0, {{{@in=@multicast1, @in, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xee00}}}, [@sec_ctx={0xc, 0x8, {0x8}}]}, 0xcc}}, 0x0)
10:52:18 executing program 2:
r0 = socket$nl_xfrm(0x10, 0x3, 0x6)
sendmsg$nl_xfrm(r0, &(0x7f0000000a00)={0x0, 0x0, &(0x7f00000009c0)={&(0x7f0000000a40)=@polexpire={0xcc, 0x1b, 0x1, 0x0, 0x0, {{{@in=@multicast1, @in, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xee00}}}, [@sec_ctx={0xc, 0x8, {0x8}}]}, 0xcc}}, 0x0)
10:52:18 executing program 2:
r0 = socket$nl_xfrm(0x10, 0x3, 0x6)
sendmsg$nl_xfrm(r0, &(0x7f0000000a00)={0x0, 0x0, &(0x7f00000009c0)={&(0x7f0000000a40)=@polexpire={0xcc, 0x1b, 0x1, 0x0, 0x0, {{{@in=@multicast1, @in, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xee00}}}, [@sec_ctx={0xc, 0x8, {0x8}}]}, 0xcc}}, 0x0)
10:52:18 executing program 1:
pidfd_getfd(0xffffffffffffffff, 0xffffffffffffffff, 0x0)
10:52:18 executing program 2:
kexec_load(0x0, 0x1, &(0x7f00000003c0)=[{0x0, 0x0, 0x0, 0x9}], 0x0)
10:52:18 executing program 2:
kexec_load(0x0, 0x1, &(0x7f00000003c0)=[{0x0, 0x0, 0x0, 0x9}], 0x0)
10:52:18 executing program 1:
pidfd_getfd(0xffffffffffffffff, 0xffffffffffffffff, 0x0)
10:52:18 executing program 2:
kexec_load(0x0, 0x1, &(0x7f00000003c0)=[{0x0, 0x0, 0x0, 0x9}], 0x0)
[ 141.306741] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1
[ 141.315467] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9
[ 141.318549] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9
[ 141.324135] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4
[ 141.328222] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3
[ 141.330046] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2
[ 141.345370] Bluetooth: hci1: HCI_REQ-0x0c1a
[ 141.478865] audit: type=1400 audit(1663239141.803:8): avc: denied { open } for pid=4481 comm="syz-executor.6" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=perf_event permissive=1
[ 141.481874] audit: type=1400 audit(1663239141.803:9): avc: denied { kernel } for pid=4481 comm="syz-executor.6" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=perf_event permissive=1
[ 141.490052] ------------[ cut here ]------------
[ 141.490088]
[ 141.490093] ======================================================
[ 141.490100] WARNING: possible circular locking dependency detected
[ 141.490107] 6.0.0-rc5-next-20220915 #1 Not tainted
[ 141.490119] ------------------------------------------------------
[ 141.490125] syz-executor.6/4482 is trying to acquire lock:
[ 141.490137] ffffffff853fa878 ((console_sem).lock){....}-{2:2}, at: down_trylock+0xe/0x70
[ 141.490209]
[ 141.490209] but task is already holding lock:
[ 141.490215] ffff88800d497820 (&ctx->lock){....}-{2:2}, at: __perf_event_task_sched_out+0x53b/0x18d0
[ 141.490267]
[ 141.490267] which lock already depends on the new lock.
[ 141.490267]
[ 141.490273]
[ 141.490273] the existing dependency chain (in reverse order) is:
[ 141.490279]
[ 141.490279] -> #3 (&ctx->lock){....}-{2:2}:
[ 141.490306] _raw_spin_lock+0x2a/0x40
[ 141.490338] __perf_event_task_sched_out+0x53b/0x18d0
[ 141.490362] __schedule+0xedd/0x2470
[ 141.490382] schedule+0xda/0x1b0
[ 141.490401] exit_to_user_mode_prepare+0x114/0x1a0
[ 141.490440] syscall_exit_to_user_mode+0x19/0x40
[ 141.490476] do_syscall_64+0x48/0x90
[ 141.490503] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 141.490538]
[ 141.490538] -> #2 (&rq->__lock){-.-.}-{2:2}:
[ 141.490564] _raw_spin_lock_nested+0x30/0x40
[ 141.490594] raw_spin_rq_lock_nested+0x1e/0x30
[ 141.490618] task_fork_fair+0x63/0x4d0
[ 141.490652] sched_cgroup_fork+0x3d0/0x540
[ 141.490679] copy_process+0x4183/0x6e20
[ 141.490699] kernel_clone+0xe7/0x890
[ 141.490717] user_mode_thread+0xad/0xf0
[ 141.490737] rest_init+0x24/0x250
[ 141.490770] arch_call_rest_init+0xf/0x14
[ 141.490791] start_kernel+0x4c1/0x4e6
[ 141.490811] secondary_startup_64_no_verify+0xe0/0xeb
[ 141.490838]
[ 141.490838] -> #1 (&p->pi_lock){-.-.}-{2:2}:
[ 141.490864] _raw_spin_lock_irqsave+0x39/0x60
[ 141.490894] try_to_wake_up+0xab/0x1920
[ 141.490920] up+0x75/0xb0
[ 141.490942] __up_console_sem+0x6e/0x80
[ 141.490973] console_unlock+0x46a/0x590
[ 141.491004] vt_ioctl+0x2822/0x2ca0
[ 141.491028] tty_ioctl+0x7c4/0x1700
[ 141.491049] __x64_sys_ioctl+0x19a/0x210
[ 141.491078] do_syscall_64+0x3b/0x90
[ 141.491105] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 141.491139]
[ 141.491139] -> #0 ((console_sem).lock){....}-{2:2}:
[ 141.491165] __lock_acquire+0x2a02/0x5e70
[ 141.491198] lock_acquire+0x1a2/0x530
[ 141.491229] _raw_spin_lock_irqsave+0x39/0x60
[ 141.491259] down_trylock+0xe/0x70
[ 141.491283] __down_trylock_console_sem+0x3b/0xd0
[ 141.491315] vprintk_emit+0x16b/0x560
[ 141.491348] vprintk+0x84/0xa0
[ 141.491380] _printk+0xba/0xf1
[ 141.491415] report_bug.cold+0x72/0xab
[ 141.491440] handle_bug+0x3c/0x70
[ 141.491466] exc_invalid_op+0x14/0x50
[ 141.491493] asm_exc_invalid_op+0x16/0x20
[ 141.491526] group_sched_out.part.0+0x2c7/0x460
[ 141.491546] ctx_sched_out+0x8f1/0xc10
[ 141.491564] __perf_event_task_sched_out+0x6d0/0x18d0
[ 141.491588] __schedule+0xedd/0x2470
[ 141.491608] schedule+0xda/0x1b0
[ 141.491627] exit_to_user_mode_prepare+0x114/0x1a0
[ 141.491665] syscall_exit_to_user_mode+0x19/0x40
[ 141.491700] do_syscall_64+0x48/0x90
[ 141.491726] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 141.491760]
[ 141.491760] other info that might help us debug this:
[ 141.491760]
[ 141.491766] Chain exists of:
[ 141.491766] (console_sem).lock --> &rq->__lock --> &ctx->lock
[ 141.491766]
[ 141.491795] Possible unsafe locking scenario:
[ 141.491795]
[ 141.491799] CPU0 CPU1
[ 141.491804] ---- ----
[ 141.491809] lock(&ctx->lock);
[ 141.491819] lock(&rq->__lock);
[ 141.491832] lock(&ctx->lock);
[ 141.491844] lock((console_sem).lock);
[ 141.491855]
[ 141.491855] *** DEADLOCK ***
[ 141.491855]
[ 141.491859] 2 locks held by syz-executor.6/4482:
[ 141.491872] #0: ffff88806ce37cd8 (&rq->__lock){-.-.}-{2:2}, at: __schedule+0x1cf/0x2470
[ 141.491923] #1: ffff88800d497820 (&ctx->lock){....}-{2:2}, at: __perf_event_task_sched_out+0x53b/0x18d0
[ 141.491977]
[ 141.491977] stack backtrace:
[ 141.491981] CPU: 0 PID: 4482 Comm: syz-executor.6 Not tainted 6.0.0-rc5-next-20220915 #1
[ 141.492006] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
[ 141.492021] Call Trace:
[ 141.492027]
[ 141.492037] dump_stack_lvl+0x8b/0xb3
[ 141.492067] check_noncircular+0x263/0x2e0
[ 141.492103] ? format_decode+0x26c/0xb50
[ 141.492130] ? print_circular_bug+0x450/0x450
[ 141.492163] ? enable_ptr_key_workfn+0x20/0x20
[ 141.492192] ? format_decode+0x26c/0xb50
[ 141.492219] ? memcpy+0x39/0x60
[ 141.492256] ? vsnprintf+0x4ba/0x1600
[ 141.492287] __lock_acquire+0x2a02/0x5e70
[ 141.492328] ? lockdep_hardirqs_on_prepare+0x410/0x410
[ 141.492371] lock_acquire+0x1a2/0x530
[ 141.492402] ? down_trylock+0xe/0x70
[ 141.492430] ? rcu_read_unlock+0x40/0x40
[ 141.492469] ? vprintk+0x84/0xa0
[ 141.492503] _raw_spin_lock_irqsave+0x39/0x60
[ 141.492534] ? down_trylock+0xe/0x70
[ 141.492559] down_trylock+0xe/0x70
[ 141.492584] ? vprintk+0x84/0xa0
[ 141.492617] __down_trylock_console_sem+0x3b/0xd0
[ 141.492649] vprintk_emit+0x16b/0x560
[ 141.492685] vprintk+0x84/0xa0
[ 141.492719] _printk+0xba/0xf1
[ 141.492753] ? record_print_text.cold+0x16/0x16
[ 141.492796] ? report_bug.cold+0x66/0xab
[ 141.492823] ? group_sched_out.part.0+0x2c7/0x460
[ 141.492844] report_bug.cold+0x72/0xab
[ 141.492873] handle_bug+0x3c/0x70
[ 141.492900] exc_invalid_op+0x14/0x50
[ 141.492928] asm_exc_invalid_op+0x16/0x20
[ 141.492961] RIP: 0010:group_sched_out.part.0+0x2c7/0x460
[ 141.492985] 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
[ 141.493007] RSP: 0018:ffff8880364dfc48 EFLAGS: 00010006
[ 141.493023] RAX: 0000000040000002 RBX: 0000000000000000 RCX: 0000000000000000
[ 141.493037] RDX: ffff888019e80000 RSI: ffffffff81566027 RDI: 0000000000000005
[ 141.493056] RBP: ffff888008660000 R08: 0000000000000005 R09: 0000000000000001
[ 141.493071] R10: 0000000000000000 R11: ffffffff865ac01b R12: ffff88800d497800
[ 141.493086] R13: ffff88806ce3d100 R14: ffffffff8547c660 R15: 0000000000000002
[ 141.493108] ? group_sched_out.part.0+0x2c7/0x460
[ 141.493133] ? group_sched_out.part.0+0x2c7/0x460
[ 141.493158] ctx_sched_out+0x8f1/0xc10
[ 141.493183] __perf_event_task_sched_out+0x6d0/0x18d0
[ 141.493213] ? lock_is_held_type+0xd7/0x130
[ 141.493251] ? __perf_cgroup_move+0x160/0x160
[ 141.493274] ? set_next_entity+0x304/0x550
[ 141.493310] ? update_curr+0x267/0x740
[ 141.493347] ? lock_is_held_type+0xd7/0x130
[ 141.493385] __schedule+0xedd/0x2470
[ 141.493411] ? io_schedule_timeout+0x150/0x150
[ 141.493446] ? rcu_read_lock_sched_held+0x3e/0x80
[ 141.493487] schedule+0xda/0x1b0
[ 141.493509] exit_to_user_mode_prepare+0x114/0x1a0
[ 141.493550] syscall_exit_to_user_mode+0x19/0x40
[ 141.493587] do_syscall_64+0x48/0x90
[ 141.493616] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 141.493652] RIP: 0033:0x7f87d16beb19
[ 141.493669] 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
[ 141.493690] RSP: 002b:00007f87cec34218 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[ 141.493712] RAX: 0000000000000001 RBX: 00007f87d17d1f68 RCX: 00007f87d16beb19
[ 141.493726] RDX: 00000000000f4240 RSI: 0000000000000081 RDI: 00007f87d17d1f6c
[ 141.493741] RBP: 00007f87d17d1f60 R08: 000000000000000e R09: 0000000000000000
[ 141.493755] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f87d17d1f6c
[ 141.493769] R13: 00007ffc5418649f R14: 00007f87cec34300 R15: 0000000000022000
[ 141.493794]
[ 141.595062] WARNING: CPU: 0 PID: 4482 at kernel/events/core.c:2309 group_sched_out.part.0+0x2c7/0x460
[ 141.596298] Modules linked in:
[ 141.596735] CPU: 0 PID: 4482 Comm: syz-executor.6 Not tainted 6.0.0-rc5-next-20220915 #1
[ 141.597845] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
[ 141.599305] RIP: 0010:group_sched_out.part.0+0x2c7/0x460
[ 141.600028] 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
[ 141.602422] RSP: 0018:ffff8880364dfc48 EFLAGS: 00010006
[ 141.603133] RAX: 0000000040000002 RBX: 0000000000000000 RCX: 0000000000000000
[ 141.604087] RDX: ffff888019e80000 RSI: ffffffff81566027 RDI: 0000000000000005
[ 141.605028] RBP: ffff888008660000 R08: 0000000000000005 R09: 0000000000000001
[ 141.605993] R10: 0000000000000000 R11: ffffffff865ac01b R12: ffff88800d497800
[ 141.606943] R13: ffff88806ce3d100 R14: ffffffff8547c660 R15: 0000000000000002
[ 141.607892] FS: 00007f87cec34700(0000) GS:ffff88806ce00000(0000) knlGS:0000000000000000
[ 141.608958] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 141.610031] CR2: 00007f87d17d2018 CR3: 00000000175dc000 CR4: 0000000000350ef0
[ 141.611029] Call Trace:
[ 141.611404]
[ 141.611715] ctx_sched_out+0x8f1/0xc10
[ 141.612248] __perf_event_task_sched_out+0x6d0/0x18d0
[ 141.612947] ? lock_is_held_type+0xd7/0x130
[ 141.613553] ? __perf_cgroup_move+0x160/0x160
[ 141.614166] ? set_next_entity+0x304/0x550
[ 141.614750] ? update_curr+0x267/0x740
[ 141.615297] ? lock_is_held_type+0xd7/0x130
[ 141.615901] __schedule+0xedd/0x2470
[ 141.616420] ? io_schedule_timeout+0x150/0x150
[ 141.617044] ? rcu_read_lock_sched_held+0x3e/0x80
[ 141.617728] schedule+0xda/0x1b0
[ 141.618196] exit_to_user_mode_prepare+0x114/0x1a0
[ 141.618880] syscall_exit_to_user_mode+0x19/0x40
[ 141.619539] do_syscall_64+0x48/0x90
[ 141.620055] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 141.620768] RIP: 0033:0x7f87d16beb19
[ 141.621273] 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
[ 141.623658] RSP: 002b:00007f87cec34218 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[ 141.624670] RAX: 0000000000000001 RBX: 00007f87d17d1f68 RCX: 00007f87d16beb19
[ 141.625635] RDX: 00000000000f4240 RSI: 0000000000000081 RDI: 00007f87d17d1f6c
[ 141.626583] RBP: 00007f87d17d1f60 R08: 000000000000000e R09: 0000000000000000
[ 141.627525] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f87d17d1f6c
[ 141.628486] R13: 00007ffc5418649f R14: 00007f87cec34300 R15: 0000000000022000
[ 141.629435]
[ 141.629753] irq event stamp: 672
[ 141.630190] hardirqs last enabled at (671): [] exit_to_user_mode_prepare+0x109/0x1a0
[ 141.631450] hardirqs last disabled at (672): [] __schedule+0x1225/0x2470
[ 141.632553] softirqs last enabled at (512): [] __irq_exit_rcu+0x11b/0x180
[ 141.633709] softirqs last disabled at (507): [] __irq_exit_rcu+0x11b/0x180
[ 141.634853] ---[ end trace 0000000000000000 ]---
[ 141.650176] hrtimer: interrupt took 18104 ns
[ 143.412232] Bluetooth: hci1: command 0x0409 tx timeout
[ 143.669208] Bluetooth: hci2: Opcode 0x c03 failed: -110
[ 143.732313] Bluetooth: hci4: Opcode 0x c03 failed: -110
[ 143.797206] Bluetooth: hci6: Opcode 0x c03 failed: -110
[ 143.797219] Bluetooth: hci5: Opcode 0x c03 failed: -110
[ 145.461224] Bluetooth: hci1: command 0x041b tx timeout
[ 147.508309] Bluetooth: hci1: command 0x040f tx timeout
[ 147.892396] Bluetooth: hci2: Opcode 0x c03 failed: -110
[ 147.956199] Bluetooth: hci4: Opcode 0x c03 failed: -110
[ 148.020203] Bluetooth: hci5: Opcode 0x c03 failed: -110
[ 148.084222] Bluetooth: hci6: Opcode 0x c03 failed: -110
[ 149.556217] Bluetooth: hci1: command 0x0419 tx timeout
VM DIAGNOSIS:
10:52:22 Registers:
info registers vcpu 0
RAX=000000000000002e RBX=00000000000003f8 RCX=0000000000000000 RDX=00000000000003f8
RSI=ffffffff822b29f1 RDI=ffffffff87641ba0 RBP=ffffffff87641b60 RSP=ffff8880364df698
R8 =0000000000000001 R9 =000000000000000a R10=000000000000002e R11=0000000000000001
R12=000000000000002e R13=ffffffff87641b60 R14=0000000000000010 R15=ffffffff822b29e0
RIP=ffffffff822b2a49 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 00007f87cec34700 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=00007f87d17d2018 CR3=00000000175dc000 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 00007f87d17a57c0 00007f87d17a57c8
YMM02=0000000000000000 0000000000000000 00007f87d17a57e0 00007f87d17a57c0
YMM03=0000000000000000 0000000000000000 00007f87d17a57c8 00007f87d17a57c0
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=dffffc0000000000 RBX=ffffffff8135b390 RCX=0000000000000000 RDX=1ffff1100204bed1
RSI=ffffffff817829bc RDI=ffff88801025f6f8 RBP=ffff88801025f6c8 RSP=ffff88801025f628
R8 =ffffffff85ee10fa R9 =ffffffff85ee10fe R10=ffffed100204bed3 R11=ffff88801025f670
R12=ffff88801025f6f8 R13=0000000000000000 R14=ffff888015f73580 R15=0000000000092cc0
RIP=ffffffff8135b39a RFL=00000282 [--S----] 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 00007fbe6c7918c0 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=0000557f065b81e8 CR3=000000000f0e4000 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 000000000000002f 002f2e2e2f002e2e
YMM01=0000000000000000 0000000000000000 0000000000000000 696c61766e49002f
YMM02=0000000000000000 0000000000000000 ffffffffffffff0f 0e0d0c0b0a090807
YMM03=0000000000000000 0000000000000000 0000550032003075 70632f302f716d2f
YMM04=0000000000000000 0000000000000000 2f2f2f2f2f2f2f2f 2f2f2f2f2f2f2f2f
YMM05=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM06=0000000000000000 0000000000000000 0000557f06575b00 ffffffff00000002
YMM07=0000000000000000 0000000000000000 0000000000000000 0000000000000000
YMM08=0000000000000000 0000000000000000 2f63697361622f63 72732f2e2e000d0a
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