[ 39.993607][ T12] bridge0: port 1(bridge_slave_0) entered disabled state [ 40.003446][ T12] veth1_macvtap: left promiscuous mode [ 40.009230][ T12] veth0_macvtap: left promiscuous mode [ 40.014784][ T12] veth1_vlan: left promiscuous mode [ 40.020279][ T12] veth0_vlan: left promiscuous mode [ 40.085506][ T12] team0 (unregistering): Port device team_slave_1 removed [ 40.097218][ T12] team0 (unregistering): Port device team_slave_0 removed [ 40.106154][ T12] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 40.120820][ T12] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 40.149651][ T12] bond0 (unregistering): Released all slaves Warning: Permanently added '10.128.10.17' (ECDSA) to the list of known hosts. 2023/05/08 02:39:45 ignoring optional flag "sandboxArg"="0" 2023/05/08 02:39:45 parsed 1 programs 2023/05/08 02:39:45 executed programs: 0 [ 53.180342][ T4356] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 53.187827][ T4356] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 53.195190][ T4356] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 53.203870][ T4356] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 53.211534][ T4356] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 53.219276][ T4356] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 53.266151][ T5262] chnl_net:caif_netlink_parms(): no params data found [ 53.290587][ T5262] bridge0: port 1(bridge_slave_0) entered blocking state [ 53.297698][ T5262] bridge0: port 1(bridge_slave_0) entered disabled state [ 53.304714][ T5262] bridge_slave_0: entered allmulticast mode [ 53.311556][ T5262] bridge_slave_0: entered promiscuous mode [ 53.318878][ T5262] bridge0: port 2(bridge_slave_1) entered blocking state [ 53.325909][ T5262] bridge0: port 2(bridge_slave_1) entered disabled state [ 53.333012][ T5262] bridge_slave_1: entered allmulticast mode [ 53.339325][ T5262] bridge_slave_1: entered promiscuous mode [ 53.353668][ T5262] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 53.364009][ T5262] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 53.380958][ T5262] team0: Port device team_slave_0 added [ 53.388421][ T5262] team0: Port device team_slave_1 added [ 53.400946][ T5262] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 53.407937][ T5262] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 53.434345][ T5262] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 53.446456][ T5262] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 53.453511][ T5262] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 53.479422][ T5262] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 53.499588][ T5262] hsr_slave_0: entered promiscuous mode [ 53.505464][ T5262] hsr_slave_1: entered promiscuous mode [ 53.898257][ T5262] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 53.906630][ T5262] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 53.915087][ T5262] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 53.924068][ T5262] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 53.939900][ T5262] bridge0: port 2(bridge_slave_1) entered blocking state [ 53.946960][ T5262] bridge0: port 2(bridge_slave_1) entered forwarding state [ 53.954212][ T5262] bridge0: port 1(bridge_slave_0) entered blocking state [ 53.961285][ T5262] bridge0: port 1(bridge_slave_0) entered forwarding state [ 53.994809][ T5262] 8021q: adding VLAN 0 to HW filter on device bond0 [ 54.007393][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 54.015372][ T4960] bridge0: port 1(bridge_slave_0) entered disabled state [ 54.025157][ T4960] bridge0: port 2(bridge_slave_1) entered disabled state [ 54.033953][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 54.046092][ T5262] 8021q: adding VLAN 0 to HW filter on device team0 [ 54.056789][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 54.065186][ T4960] bridge0: port 1(bridge_slave_0) entered blocking state [ 54.072269][ T4960] bridge0: port 1(bridge_slave_0) entered forwarding state [ 54.089452][ T5346] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 54.098317][ T5346] bridge0: port 2(bridge_slave_1) entered blocking state [ 54.105350][ T5346] bridge0: port 2(bridge_slave_1) entered forwarding state [ 54.113585][ T5346] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 54.124660][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 54.132618][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 54.142474][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 54.154608][ T5262] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 54.166079][ T5262] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 54.173910][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 54.236807][ T5262] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 54.247448][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 54.256431][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 54.276188][ T5262] veth0_vlan: entered promiscuous mode [ 54.282337][ T73] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 54.291007][ T73] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 54.300408][ T73] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 54.310116][ T73] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 54.321228][ T5262] veth1_vlan: entered promiscuous mode [ 54.330913][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 54.339535][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 54.347348][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 54.363333][ T5262] veth0_macvtap: entered promiscuous mode [ 54.371237][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 54.379620][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 54.388363][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 54.398193][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 54.408745][ T5262] veth1_macvtap: entered promiscuous mode [ 54.420840][ T5262] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 54.429071][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 54.437321][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 54.454231][ T4363] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 54.465288][ T5262] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 54.475955][ T5262] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.485073][ T5262] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.494079][ T5262] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.503097][ T5262] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.513814][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 54.522485][ T4959] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 54.568565][ T12] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 54.576486][ T12] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 54.598290][ T40] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 54.606151][ T40] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 54.615651][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 54.626486][ T4960] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 54.717743][ T4363] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 54.727210][ T4363] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 4363, name: kworker/1:3 [ 54.736286][ T4363] preempt_count: 1, expected: 0 [ 54.741107][ T4363] RCU nest depth: 0, expected: 0 [ 54.746114][ T4363] 3 locks held by kworker/1:3/4363: [ 54.751294][ T4363] #0: ffff888010c70d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x793/0x1410 [ 54.761615][ T4363] #1: ffffc9000532fdc0 ((work_completion)(&gsm->tx_work)){+.+.}-{0:0}, at: process_one_work+0x7c0/0x1410 [ 54.772904][ T4363] #2: ffff88801eedd3e0 (&gsm->tx_lock){....}-{2:2}, at: gsmld_write_task+0x2c/0xd60 [ 54.782362][ T4363] irq event stamp: 4790 [ 54.786487][ T4363] hardirqs last enabled at (4789): [] _raw_spin_unlock_irq+0x1f/0x40 [ 54.796170][ T4363] hardirqs last disabled at (4790): [] _raw_spin_lock_irqsave+0x4e/0x50 [ 54.806028][ T4363] softirqs last enabled at (4782): [] do_softirq.part.0+0xde/0x130 [ 54.815538][ T4363] softirqs last disabled at (4759): [] do_softirq.part.0+0xde/0x130 [ 54.825044][ T4363] Preemption disabled at: [ 54.825047][ T4363] [<0000000000000000>] 0x0 [ 54.833999][ T4363] CPU: 1 PID: 4363 Comm: kworker/1:3 Not tainted 6.4.0-rc1-syzkaller #0 [ 54.842292][ T4363] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 54.852492][ T4363] Workqueue: events gsmld_write_task [ 54.857751][ T4363] Call Trace: [ 54.861004][ T4363] [ 54.863913][ T4363] dump_stack_lvl+0x60/0xa0 [ 54.868388][ T4363] __might_resched+0x354/0x580 [ 54.873125][ T4363] console_lock+0x11/0x60 [ 54.877425][ T4363] do_con_write+0xf2/0x19c0 [ 54.881896][ T4363] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 54.887844][ T4363] ? do_con_trol+0x4e60/0x4e60 [ 54.892572][ T4363] ? lock_acquire+0x1ad/0x520 [ 54.897214][ T4363] ? lock_sync+0x180/0x180 [ 54.901593][ T4363] ? do_raw_spin_lock+0x120/0x2a0 [ 54.906585][ T4363] con_write+0xb/0x20 [ 54.910543][ T4363] gsm_send_packet+0x35d/0x940 [ 54.915272][ T4363] gsmld_write_task+0x1d6/0xd60 [ 54.920091][ T4363] process_one_work+0x86e/0x1410 [ 54.925001][ T4363] ? lock_sync+0x180/0x180 [ 54.929398][ T4363] ? pwq_dec_nr_in_flight+0x230/0x230 [ 54.934736][ T4363] ? spin_bug+0x1c0/0x1c0 [ 54.939031][ T4363] worker_thread+0x5ab/0xef0 [ 54.943587][ T4363] ? process_one_work+0x1410/0x1410 [ 54.948746][ T4363] kthread+0x2e6/0x3c0 [ 54.952794][ T4363] ? kthread_complete_and_exit+0x20/0x20 [ 54.958391][ T4363] ret_from_fork+0x1f/0x30 [ 54.962785][ T4363] [ 54.976756][ C0] [ 54.979078][ C0] ======================================================== [ 54.986245][ C0] WARNING: possible irq lock inversion dependency detected [ 54.993414][ C0] 6.4.0-rc1-syzkaller #0 Tainted: G W [ 55.000238][ C0] -------------------------------------------------------- [ 55.007495][ C0] udevd/5403 just changed the state of lock: [ 55.013448][ C0] ffff88801eedd3e0 (&gsm->tx_lock){..-.}-{2:2}, at: gsm_send.isra.0+0x32d/0x840 [ 55.022462][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 55.029979][ C0] (console_lock){+.+.}-{0:0} [ 55.029989][ C0] [ 55.029989][ C0] [ 55.029989][ C0] and interrupts could create inverse lock ordering between them. [ 55.029989][ C0] [ 55.048943][ C0] [ 55.048943][ C0] other info that might help us debug this: [ 55.056980][ C0] Possible interrupt unsafe locking scenario: [ 55.056980][ C0] [ 55.065296][ C0] CPU0 CPU1 [ 55.070648][ C0] ---- ---- [ 55.075990][ C0] lock(console_lock); [ 55.080126][ C0] local_irq_disable(); [ 55.086860][ C0] lock(&gsm->tx_lock); [ 55.093598][ C0] lock(console_lock); [ 55.100255][ C0] [ 55.103687][ C0] lock(&gsm->tx_lock); [ 55.108076][ C0] [ 55.108076][ C0] *** DEADLOCK *** [ 55.108076][ C0] [ 55.116195][ C0] 2 locks held by udevd/5403: [ 55.120841][ C0] #0: ffffffff8b9af970 (tomoyo_ss){.+.+}-{0:0}, at: tomoyo_check_open_permission+0xe1/0x2e0 [ 55.130996][ C0] #1: ffffc90000007d78 ((&dlci->t1)){+.-.}-{0:0}, at: call_timer_fn+0xcd/0x400 [ 55.140019][ C0] [ 55.140019][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 55.149375][ C0] -> (console_lock){+.+.}-{0:0} { [ 55.154475][ C0] HARDIRQ-ON-W at: [ 55.158614][ C0] lock_acquire+0x1ad/0x520 [ 55.164936][ C0] console_lock+0x40/0x60 [ 55.171076][ C0] con_init+0x11/0x710 [ 55.176947][ C0] console_init+0x80/0x3f0 [ 55.183166][ C0] start_kernel+0x1fc/0x340 [ 55.189467][ C0] x86_64_start_reservations+0x14/0x30 [ 55.196722][ C0] x86_64_start_kernel+0xaf/0xc0 [ 55.203541][ C0] secondary_startup_64_no_verify+0xf4/0xfb [ 55.211325][ C0] SOFTIRQ-ON-W at: [ 55.215396][ C0] lock_acquire+0x1ad/0x520 [ 55.221695][ C0] console_lock+0x40/0x60 [ 55.227820][ C0] con_init+0x11/0x710 [ 55.233681][ C0] console_init+0x80/0x3f0 [ 55.239894][ C0] start_kernel+0x1fc/0x340 [ 55.246189][ C0] x86_64_start_reservations+0x14/0x30 [ 55.253438][ C0] x86_64_start_kernel+0xaf/0xc0 [ 55.260174][ C0] secondary_startup_64_no_verify+0xf4/0xfb [ 55.267859][ C0] INITIAL USE at: [ 55.271807][ C0] } [ 55.274365][ C0] ... key at: [] console_lock_dep_map+0x0/0x60 [ 55.282664][ C0] ... acquired at: [ 55.286526][ C0] console_lock+0x40/0x60 [ 55.291002][ C0] do_con_write+0xf2/0x19c0 [ 55.295646][ C0] con_write+0xb/0x20 [ 55.299768][ C0] gsm_send_packet+0x35d/0x940 [ 55.304681][ C0] gsmld_write_task+0x1d6/0xd60 [ 55.309671][ C0] process_one_work+0x86e/0x1410 [ 55.314749][ C0] worker_thread+0x5ab/0xef0 [ 55.319478][ C0] kthread+0x2e6/0x3c0 [ 55.323688][ C0] ret_from_fork+0x1f/0x30 [ 55.328250][ C0] [ 55.330550][ C0] -> (&gsm->tx_lock){..-.}-{2:2} { [ 55.335636][ C0] IN-SOFTIRQ-W at: [ 55.339588][ C0] lock_acquire+0x1ad/0x520 [ 55.345716][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 55.352547][ C0] gsm_send.isra.0+0x32d/0x840 [ 55.358931][ C0] gsm_dlci_begin_close+0x113/0x210 [ 55.365752][ C0] gsm_dlci_t1+0x1a4/0x540 [ 55.371891][ C0] call_timer_fn+0x163/0x400 [ 55.378103][ C0] expire_timers+0x224/0x400 [ 55.384319][ C0] run_timer_softirq+0x292/0x790 [ 55.390880][ C0] __do_softirq+0x1d0/0x901 [ 55.397009][ C0] __irq_exit_rcu+0x114/0x190 [ 55.403319][ C0] irq_exit_rcu+0x5/0x20 [ 55.409184][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 55.416447][ C0] asm_sysvec_apic_timer_interrupt+0x16/0x20 [ 55.424053][ C0] __kasan_kmalloc+0x7/0xa0 [ 55.430181][ C0] __kmalloc+0x5a/0x190 [ 55.436045][ C0] tomoyo_realpath_from_path+0xa4/0x650 [ 55.443216][ C0] tomoyo_check_open_permission+0x23b/0x2e0 [ 55.450731][ C0] security_file_open+0x34/0x80 [ 55.457201][ C0] do_dentry_open+0x33e/0x1140 [ 55.463577][ C0] path_openat+0x12a5/0x2280 [ 55.469871][ C0] do_filp_open+0x1a5/0x3d0 [ 55.475988][ C0] do_sys_openat2+0x11e/0x3f0 [ 55.482274][ C0] __x64_sys_openat+0x11b/0x1d0 [ 55.488828][ C0] do_syscall_64+0x35/0xb0 [ 55.495291][ C0] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 55.502818][ C0] INITIAL USE at: [ 55.506678][ C0] lock_acquire+0x1ad/0x520 [ 55.512717][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 55.519551][ C0] gsm_send.isra.0+0x32d/0x840 [ 55.525841][ C0] gsm_dlci_begin_open+0x346/0x5c0 [ 55.532477][ C0] gsmld_ioctl+0x10e0/0x16a0 [ 55.538595][ C0] tty_ioctl+0x548/0x1280 [ 55.544455][ C0] __x64_sys_ioctl+0x11f/0x190 [ 55.550746][ C0] do_syscall_64+0x35/0xb0 [ 55.556689][ C0] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 55.564107][ C0] } [ 55.566573][ C0] ... key at: [] __key.10+0x0/0x40 [ 55.573742][ C0] ... acquired at: [ 55.577518][ C0] __lock_acquire+0x11ed/0x5df0 [ 55.582622][ C0] lock_acquire+0x1ad/0x520 [ 55.587277][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 55.592704][ C0] gsm_send.isra.0+0x32d/0x840 [ 55.597641][ C0] gsm_dlci_begin_close+0x113/0x210 [ 55.602982][ C0] gsm_dlci_t1+0x1a4/0x540 [ 55.607534][ C0] call_timer_fn+0x163/0x400 [ 55.612263][ C0] expire_timers+0x224/0x400 [ 55.617015][ C0] run_timer_softirq+0x292/0x790 [ 55.622087][ C0] __do_softirq+0x1d0/0x901 [ 55.626733][ C0] __irq_exit_rcu+0x114/0x190 [ 55.631549][ C0] irq_exit_rcu+0x5/0x20 [ 55.635934][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 55.641706][ C0] asm_sysvec_apic_timer_interrupt+0x16/0x20 [ 55.647833][ C0] __kasan_kmalloc+0x7/0xa0 [ 55.652475][ C0] __kmalloc+0x5a/0x190 [ 55.656767][ C0] tomoyo_realpath_from_path+0xa4/0x650 [ 55.662449][ C0] tomoyo_check_open_permission+0x23b/0x2e0 [ 55.668477][ C0] security_file_open+0x34/0x80 [ 55.673553][ C0] do_dentry_open+0x33e/0x1140 [ 55.678455][ C0] path_openat+0x12a5/0x2280 [ 55.683182][ C0] do_filp_open+0x1a5/0x3d0 [ 55.687822][ C0] do_sys_openat2+0x11e/0x3f0 [ 55.692637][ C0] __x64_sys_openat+0x11b/0x1d0 [ 55.697623][ C0] do_syscall_64+0x35/0xb0 [ 55.702178][ C0] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 55.708208][ C0] [ 55.710502][ C0] [ 55.710502][ C0] stack backtrace: [ 55.716359][ C0] CPU: 0 PID: 5403 Comm: udevd Tainted: G W 6.4.0-rc1-syzkaller #0 [ 55.725609][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 55.736001][ C0] Call Trace: [ 55.739258][ C0] [ 55.742074][ C0] dump_stack_lvl+0x60/0xa0 [ 55.746546][ C0] print_irq_inversion_bug.part.0+0x3d9/0x580 [ 55.752669][ C0] ? print_shortest_lock_dependencies+0x1a0/0x1a0 [ 55.759045][ C0] mark_lock.part.0+0xb79/0x1970 [ 55.763946][ C0] ? print_usage_bug.part.0+0x660/0x660 [ 55.769459][ C0] ? __stack_depot_save+0x237/0x510 [ 55.774711][ C0] ? mark_held_locks+0x9f/0xe0 [ 55.779442][ C0] ? lockdep_hardirqs_on+0x79/0x100 [ 55.784607][ C0] ? _raw_spin_unlock_irqrestore+0x3d/0x70 [ 55.790462][ C0] ? __stack_depot_save+0x237/0x510 [ 55.795624][ C0] __lock_acquire+0x11ed/0x5df0 [ 55.800463][ C0] ? gsm_dlci_t1+0xb2/0x540 [ 55.804931][ C0] ? run_timer_softirq+0x292/0x790 [ 55.810097][ C0] ? __do_softirq+0x1d0/0x901 [ 55.814911][ C0] ? __irq_exit_rcu+0x114/0x190 [ 55.819817][ C0] ? irq_exit_rcu+0x5/0x20 [ 55.824196][ C0] ? sysvec_apic_timer_interrupt+0x93/0xc0 [ 55.829970][ C0] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 55.835919][ C0] ? tomoyo_realpath_from_path+0xa4/0x650 [ 55.841690][ C0] ? tomoyo_check_open_permission+0x23b/0x2e0 [ 55.847726][ C0] ? security_file_open+0x34/0x80 [ 55.852974][ C0] ? do_dentry_open+0x33e/0x1140 [ 55.857875][ C0] ? path_openat+0x12a5/0x2280 [ 55.862604][ C0] ? do_filp_open+0x1a5/0x3d0 [ 55.867258][ C0] ? do_sys_openat2+0x11e/0x3f0 [ 55.872172][ C0] ? __x64_sys_openat+0x11b/0x1d0 [ 55.877188][ C0] ? do_syscall_64+0x35/0xb0 [ 55.881742][ C0] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 55.887774][ C0] ? exc_int3+0xb/0x80 [ 55.891807][ C0] lock_acquire+0x1ad/0x520 [ 55.896277][ C0] ? gsm_send.isra.0+0x32d/0x840 [ 55.901183][ C0] ? lock_sync+0x180/0x180 [ 55.905651][ C0] ? __kmem_cache_alloc_node+0x20b/0x310 [ 55.911264][ C0] ? __kmem_cache_alloc_node+0x1a8/0x310 [ 55.916859][ C0] ? gsm_send.isra.0+0x4f/0x840 [ 55.921676][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 55.926842][ C0] ? gsm_send.isra.0+0x32d/0x840 [ 55.931756][ C0] gsm_send.isra.0+0x32d/0x840 [ 55.936485][ C0] ? lock_acquire+0x1ad/0x520 [ 55.941129][ C0] gsm_dlci_begin_close+0x113/0x210 [ 55.946291][ C0] gsm_dlci_t1+0x1a4/0x540 [ 55.950679][ C0] ? gsmtty_ioctl+0xee0/0xee0 [ 55.955341][ C0] ? gsmtty_ioctl+0xee0/0xee0 [ 55.959981][ C0] call_timer_fn+0x163/0x400 [ 55.964538][ C0] ? msleep_interruptible+0x120/0x120 [ 55.969875][ C0] ? lock_downgrade+0x690/0x690 [ 55.974714][ C0] ? mark_held_locks+0x9f/0xe0 [ 55.979445][ C0] expire_timers+0x224/0x400 [ 55.983997][ C0] ? gsmtty_ioctl+0xee0/0xee0 [ 55.988636][ C0] run_timer_softirq+0x292/0x790 [ 55.993538][ C0] ? expire_timers+0x400/0x400 [ 55.998273][ C0] ? kvm_clock_read+0x14/0x30 [ 56.002912][ C0] ? mark_held_locks+0x9f/0xe0 [ 56.007642][ C0] __do_softirq+0x1d0/0x901 [ 56.012116][ C0] __irq_exit_rcu+0x114/0x190 [ 56.016765][ C0] irq_exit_rcu+0x5/0x20 [ 56.020970][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 56.026569][ C0] [ 56.029476][ C0] [ 56.032383][ C0] asm_sysvec_apic_timer_interrupt+0x16/0x20 [ 56.038438][ C0] RIP: 0010:__kasan_kmalloc+0x7/0xa0 [ 56.043687][ C0] Code: 00 00 01 00 74 12 48 8b 57 48 f6 c2 01 74 09 48 83 ea 01 48 39 d7 75 c7 c3 66 2e 0f 1f 84 00 00 00 00 00 41 55 49 89 d5 41 54 <41> 89 cc 81 e1 00 04 00 00 55 48 89 fd 53 48 89 f3 75 63 48 85 db [ 56.063279][ C0] RSP: 0018:ffffc90004e0f780 EFLAGS: 00000286 [ 56.069313][ C0] RAX: ffff888027cfe000 RBX: 0000000000000c40 RCX: 0000000000000c40 [ 56.077251][ C0] RDX: 0000000000001000 RSI: ffff888027cfe000 RDI: ffff888010c42140 [ 56.085189][ C0] RBP: ffff888010c42140 R08: ffffc90004e0f750 R09: 0000000000000000 [ 56.093132][ C0] R10: ffff888027cfe000 R11: 0000000000000000 R12: 0000000000001000 [ 56.101068][ C0] R13: 0000000000001000 R14: ffffffff837cea54 R15: 0000000000000000 [ 56.109096][ C0] ? tomoyo_realpath_from_path+0xa4/0x650 [ 56.114789][ C0] __kmalloc+0x5a/0x190 [ 56.118909][ C0] ? rcu_is_watching+0xe/0xb0 [ 56.123551][ C0] tomoyo_realpath_from_path+0xa4/0x650 [ 56.129147][ C0] tomoyo_check_open_permission+0x23b/0x2e0 [ 56.136138][ C0] ? tomoyo_path_number_perm+0x4b0/0x4b0 [ 56.141734][ C0] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 56.147766][ C0] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 56.153736][ C0] ? spin_bug+0x1c0/0x1c0 [ 56.158086][ C0] security_file_open+0x34/0x80 [ 56.162912][ C0] do_dentry_open+0x33e/0x1140 [ 56.167644][ C0] ? may_open+0xce/0x330 [ 56.171854][ C0] path_openat+0x12a5/0x2280 [ 56.176503][ C0] ? path_lookupat+0x750/0x750 [ 56.181231][ C0] ? find_held_lock+0x2d/0x110 [ 56.186919][ C0] do_filp_open+0x1a5/0x3d0 [ 56.191386][ C0] ? may_open_dev+0xd0/0xd0 [ 56.195852][ C0] ? find_held_lock+0x2d/0x110 [ 56.200674][ C0] ? do_raw_spin_lock+0x120/0x2a0 [ 56.205773][ C0] ? spin_bug+0x1c0/0x1c0 [ 56.210157][ C0] ? _raw_spin_unlock+0x24/0x40 [ 56.214978][ C0] ? alloc_fd+0x1e4/0x640 [ 56.219293][ C0] ? getname_flags.part.0+0x89/0x440 [ 56.224543][ C0] do_sys_openat2+0x11e/0x3f0 [ 56.229184][ C0] ? build_open_flags+0x4a0/0x4a0 [ 56.234174][ C0] ? __ct_user_enter+0xf9/0x130 [ 56.239080][ C0] ? lock_downgrade+0x690/0x690 [ 56.243895][ C0] __x64_sys_openat+0x11b/0x1d0 [ 56.248713][ C0] ? vtime_user_exit+0x218/0x6c0 [ 56.253618][ C0] ? __ia32_sys_open+0x190/0x190 [ 56.258518][ C0] ? syscall_enter_from_user_mode+0x22/0x80 [ 56.264377][ C0] ? lockdep_hardirqs_on+0x79/0x100 [ 56.269540][ C0] do_syscall_64+0x35/0xb0 [ 56.273922][ C0] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 56.279780][ C0] RIP: 0033:0x7f894a7169a4 [ 56.284160][ C0] Code: 24 20 48 8d 44 24 30 48 89 44 24 28 64 8b 04 25 18 00 00 00 85 c0 75 2c 44 89 e2 48 89 ee bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 76 60 48 8b 15 55 a4 0d 00 f7 d8 64 89 02 48 83 [ 56.303731][ C0] RSP: 002b:00007ffcc0589b60 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 [ 56.312105][ C0] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f894a7169a4 [ 56.320045][ C0] RDX: 0000000000080241 RSI: 00007ffcc058a0a8 RDI: 00000000ffffff9c [ 56.327981][ C0] RBP: 00007ffcc058a0a8 R08: 0000000000000004 R09: 0000000000000001 [ 56.335950][ C0] R10: 00000000000001b6 R11: 0000000000000246 R12: 0000000000080241 [ 56.343978][ C0] R13: 0000556b6910772e R14: 0000000000000001 R15: 0000556b69122160 [ 56.351916][ C0] [ 56.355220][ T4356] Bluetooth: hci0: command 0x0409 tx timeout [ 56.419790][ T5346] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 56.429425][ T5346] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 5346, name: kworker/0:6 [ 56.438596][ T5346] preempt_count: 1, expected: 0 [ 56.443439][ T5346] RCU nest depth: 0, expected: 0 [ 56.448352][ T5346] INFO: lockdep is turned off. [ 56.453090][ T5346] irq event stamp: 2190 [ 56.457218][ T5346] hardirqs last enabled at (2189): [] _raw_spin_unlock_irq+0x1f/0x40 [ 56.467002][ T5346] hardirqs last disabled at (2190): [] __schedule+0x286a/0x57f0 [ 56.476175][ T5346] softirqs last enabled at (2186): [] do_softirq.part.0+0xde/0x130 [ 56.485693][ T5346] softirqs last disabled at (2137): [] do_softirq.part.0+0xde/0x130 [ 56.495414][ T5346] Preemption disabled at: [ 56.495417][ T5346] [<0000000000000000>] 0x0 [ 56.504113][ T5346] CPU: 0 PID: 5346 Comm: kworker/0:6 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 56.513899][ T5346] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 56.523962][ T5346] Workqueue: events gsmld_write_task [ 56.529227][ T5346] Call Trace: [ 56.532487][ T5346] [ 56.535489][ T5346] dump_stack_lvl+0x60/0xa0 [ 56.539972][ T5346] __might_resched+0x354/0x580 [ 56.544799][ T5346] ? try_to_wake_up+0xceb/0x1c40 [ 56.549715][ T5346] console_lock+0x11/0x60 [ 56.554025][ T5346] do_con_write+0xf2/0x19c0 [ 56.558508][ T5346] ? rcu_is_watching+0xe/0xb0 [ 56.563165][ T5346] ? rcu_is_watching+0xe/0xb0 [ 56.567904][ T5346] ? rcu_is_watching+0xe/0xb0 [ 56.572554][ T5346] ? rcu_is_watching+0xe/0xb0 [ 56.577248][ T5346] ? lock_release+0x4f7/0x670 [ 56.581908][ T5346] ? do_con_trol+0x4e60/0x4e60 [ 56.586665][ T5346] ? rcu_is_watching+0xe/0xb0 [ 56.591318][ T5346] ? lock_acquire+0x46c/0x520 [ 56.595980][ T5346] ? lock_sync+0x180/0x180 [ 56.600402][ T5346] ? do_raw_spin_lock+0x120/0x2a0 [ 56.605411][ T5346] con_write+0xb/0x20 [ 56.609377][ T5346] gsm_send_packet+0x35d/0x940 [ 56.614124][ T5346] gsmld_write_task+0x1d6/0xd60 [ 56.618950][ T5346] process_one_work+0x86e/0x1410 [ 56.623870][ T5346] ? lock_sync+0x180/0x180 [ 56.628286][ T5346] ? pwq_dec_nr_in_flight+0x230/0x230 [ 56.633638][ T5346] ? spin_bug+0x1c0/0x1c0 [ 56.637944][ T5346] worker_thread+0x5ab/0xef0 [ 56.642513][ T5346] ? process_one_work+0x1410/0x1410 [ 56.647688][ T5346] kthread+0x2e6/0x3c0 [ 56.651733][ T5346] ? kthread_complete_and_exit+0x20/0x20 [ 56.657340][ T5346] ret_from_fork+0x1f/0x30 [ 56.661741][ T5346] 2023/05/08 02:39:50 executed programs: 6 [ 57.463120][ T4959] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 57.472497][ T4959] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 4959, name: kworker/1:4 [ 57.481577][ T4959] preempt_count: 1, expected: 0 [ 57.486425][ T4959] RCU nest depth: 0, expected: 0 [ 57.491333][ T4959] INFO: lockdep is turned off. [ 57.496071][ T4959] irq event stamp: 3641650 [ 57.500460][ T4959] hardirqs last enabled at (3641649): [] _raw_spin_unlock_irq+0x1f/0x40 [ 57.510424][ T4959] hardirqs last disabled at (3641650): [] __schedule+0x286a/0x57f0 [ 57.519940][ T4959] softirqs last enabled at (3641646): [] wg_packet_encrypt_worker+0x7c6/0xb60 [ 57.530498][ T4959] softirqs last disabled at (3641644): [] wg_packet_encrypt_worker+0xd4/0xb60 [ 57.540974][ T4959] Preemption disabled at: [ 57.540977][ T4959] [<0000000000000000>] 0x0 [ 57.549664][ T4959] CPU: 1 PID: 4959 Comm: kworker/1:4 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 57.559440][ T4959] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 57.569562][ T4959] Workqueue: events gsmld_write_task [ 57.574829][ T4959] Call Trace: [ 57.578089][ T4959] [ 57.580999][ T4959] dump_stack_lvl+0x60/0xa0 [ 57.585484][ T4959] __might_resched+0x354/0x580 [ 57.590236][ T4959] console_lock+0x11/0x60 [ 57.594540][ T4959] do_con_write+0xf2/0x19c0 [ 57.599110][ T4959] ? rcu_is_watching+0xe/0xb0 [ 57.603802][ T4959] ? rcu_is_watching+0xe/0xb0 [ 57.608454][ T4959] ? rcu_is_watching+0xe/0xb0 [ 57.613114][ T4959] ? rcu_is_watching+0xe/0xb0 [ 57.617781][ T4959] ? lock_release+0x4f7/0x670 [ 57.622435][ T4959] ? do_con_trol+0x4e60/0x4e60 [ 57.627181][ T4959] ? rcu_is_watching+0xe/0xb0 [ 57.631834][ T4959] ? lock_acquire+0x46c/0x520 [ 57.636491][ T4959] ? lock_sync+0x180/0x180 [ 57.640889][ T4959] ? do_raw_spin_lock+0x120/0x2a0 [ 57.646060][ T4959] con_write+0xb/0x20 [ 57.650020][ T4959] gsm_send_packet+0x35d/0x940 [ 57.654760][ T4959] gsmld_write_task+0x1d6/0xd60 [ 57.659589][ T4959] process_one_work+0x86e/0x1410 [ 57.664507][ T4959] ? lock_sync+0x180/0x180 [ 57.668897][ T4959] ? pwq_dec_nr_in_flight+0x230/0x230 [ 57.674248][ T4959] ? spin_bug+0x1c0/0x1c0 [ 57.678574][ T4959] worker_thread+0x5ab/0xef0 [ 57.683139][ T4959] ? process_one_work+0x1410/0x1410 [ 57.688416][ T4959] kthread+0x2e6/0x3c0 [ 57.692462][ T4959] ? kthread_complete_and_exit+0x20/0x20 [ 57.698084][ T4959] ret_from_fork+0x1f/0x30 [ 57.702491][ T4959] [ 58.386633][ T46] Bluetooth: hci0: command 0x041b tx timeout [ 58.550081][ T4959] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 58.559650][ T4959] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 4959, name: kworker/1:4 [ 58.568767][ T4959] preempt_count: 1, expected: 0 [ 58.573584][ T4959] RCU nest depth: 0, expected: 0 [ 58.578570][ T4959] INFO: lockdep is turned off. [ 58.583294][ T4959] irq event stamp: 3641650 [ 58.587671][ T4959] hardirqs last enabled at (3641649): [] _raw_spin_unlock_irq+0x1f/0x40 [ 58.597624][ T4959] hardirqs last disabled at (3641650): [] __schedule+0x286a/0x57f0 [ 58.607043][ T4959] softirqs last enabled at (3641646): [] wg_packet_encrypt_worker+0x7c6/0xb60 [ 58.617679][ T4959] softirqs last disabled at (3641644): [] wg_packet_encrypt_worker+0xd4/0xb60 [ 58.628057][ T4959] Preemption disabled at: [ 58.628060][ T4959] [<0000000000000000>] 0x0 [ 58.636740][ T4959] CPU: 1 PID: 4959 Comm: kworker/1:4 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 58.646515][ T4959] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 58.656548][ T4959] Workqueue: events gsmld_write_task [ 58.661806][ T4959] Call Trace: [ 58.665052][ T4959] [ 58.667952][ T4959] dump_stack_lvl+0x60/0xa0 [ 58.673028][ T4959] __might_resched+0x354/0x580 [ 58.677782][ T4959] console_lock+0x11/0x60 [ 58.682073][ T4959] do_con_write+0xf2/0x19c0 [ 58.686538][ T4959] ? rcu_is_watching+0xe/0xb0 [ 58.691175][ T4959] ? rcu_is_watching+0xe/0xb0 [ 58.695811][ T4959] ? rcu_is_watching+0xe/0xb0 [ 58.700450][ T4959] ? rcu_is_watching+0xe/0xb0 [ 58.705084][ T4959] ? lock_release+0x4f7/0x670 [ 58.709725][ T4959] ? do_con_trol+0x4e60/0x4e60 [ 58.714451][ T4959] ? rcu_is_watching+0xe/0xb0 [ 58.719086][ T4959] ? lock_acquire+0x46c/0x520 [ 58.723725][ T4959] ? lock_sync+0x180/0x180 [ 58.728362][ T4959] ? do_raw_spin_lock+0x120/0x2a0 [ 58.733345][ T4959] con_write+0xb/0x20 [ 58.737288][ T4959] gsm_send_packet+0x35d/0x940 [ 58.742010][ T4959] gsmld_write_task+0x1d6/0xd60 [ 58.746822][ T4959] process_one_work+0x86e/0x1410 [ 58.751745][ T4959] ? lock_sync+0x180/0x180 [ 58.756121][ T4959] ? pwq_dec_nr_in_flight+0x230/0x230 [ 58.761451][ T4959] ? spin_bug+0x1c0/0x1c0 [ 58.765742][ T4959] worker_thread+0x5ab/0xef0 [ 58.770315][ T4959] ? process_one_work+0x1410/0x1410 [ 58.775471][ T4959] kthread+0x2e6/0x3c0 [ 58.779516][ T4959] ? kthread_complete_and_exit+0x20/0x20 [ 58.785122][ T4959] ret_from_fork+0x1f/0x30 [ 58.789503][ T4959] [ 59.616169][ T5346] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 59.625561][ T5346] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 5346, name: kworker/0:6 [ 59.634643][ T5346] preempt_count: 1, expected: 0 [ 59.639557][ T5346] RCU nest depth: 0, expected: 0 [ 59.644553][ T5346] INFO: lockdep is turned off. [ 59.649293][ T5346] irq event stamp: 2190 [ 59.653421][ T5346] hardirqs last enabled at (2189): [] _raw_spin_unlock_irq+0x1f/0x40 [ 59.663122][ T5346] hardirqs last disabled at (2190): [] __schedule+0x286a/0x57f0 [ 59.672296][ T5346] softirqs last enabled at (2186): [] do_softirq.part.0+0xde/0x130 [ 59.681818][ T5346] softirqs last disabled at (2137): [] do_softirq.part.0+0xde/0x130 [ 59.691346][ T5346] Preemption disabled at: [ 59.691348][ T5346] [<0000000000000000>] 0x0 [ 59.700012][ T5346] CPU: 0 PID: 5346 Comm: kworker/0:6 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 59.709775][ T5346] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 59.719797][ T5346] Workqueue: events gsmld_write_task [ 59.726181][ T5346] Call Trace: [ 59.729433][ T5346] [ 59.732349][ T5346] dump_stack_lvl+0x60/0xa0 [ 59.736814][ T5346] __might_resched+0x354/0x580 [ 59.741555][ T5346] ? try_to_wake_up+0xceb/0x1c40 [ 59.746451][ T5346] console_lock+0x11/0x60 [ 59.750759][ T5346] do_con_write+0xf2/0x19c0 [ 59.755223][ T5346] ? rcu_is_watching+0xe/0xb0 [ 59.759858][ T5346] ? rcu_is_watching+0xe/0xb0 [ 59.764491][ T5346] ? rcu_is_watching+0xe/0xb0 [ 59.769213][ T5346] ? rcu_is_watching+0xe/0xb0 [ 59.773849][ T5346] ? lock_release+0x4f7/0x670 [ 59.778487][ T5346] ? do_con_trol+0x4e60/0x4e60 [ 59.783208][ T5346] ? rcu_is_watching+0xe/0xb0 [ 59.787844][ T5346] ? lock_acquire+0x46c/0x520 [ 59.792480][ T5346] ? lock_sync+0x180/0x180 [ 59.796856][ T5346] ? do_raw_spin_lock+0x120/0x2a0 [ 59.801839][ T5346] con_write+0xb/0x20 [ 59.805780][ T5346] gsm_send_packet+0x35d/0x940 [ 59.810502][ T5346] gsmld_write_task+0x1d6/0xd60 [ 59.815399][ T5346] process_one_work+0x86e/0x1410 [ 59.820314][ T5346] ? lock_sync+0x180/0x180 [ 59.824780][ T5346] ? pwq_dec_nr_in_flight+0x230/0x230 [ 59.830107][ T5346] ? spin_bug+0x1c0/0x1c0 [ 59.834394][ T5346] worker_thread+0x5ab/0xef0 [ 59.838946][ T5346] ? process_one_work+0x1410/0x1410 [ 59.844100][ T5346] kthread+0x2e6/0x3c0 [ 59.848127][ T5346] ? kthread_complete_and_exit+0x20/0x20 [ 59.853717][ T5346] ret_from_fork+0x1f/0x30 [ 59.858182][ T5346] [ 60.456686][ T46] Bluetooth: hci0: command 0x040f tx timeout [ 60.607568][ T4959] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 60.616950][ T4959] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 4959, name: kworker/1:4 [ 60.626118][ T4959] preempt_count: 1, expected: 0 [ 60.631297][ T4959] RCU nest depth: 0, expected: 0 [ 60.636211][ T4959] INFO: lockdep is turned off. [ 60.640944][ T4959] irq event stamp: 3641650 [ 60.645326][ T4959] hardirqs last enabled at (3641649): [] _raw_spin_unlock_irq+0x1f/0x40 [ 60.655270][ T4959] hardirqs last disabled at (3641650): [] __schedule+0x286a/0x57f0 [ 60.664688][ T4959] softirqs last enabled at (3641646): [] wg_packet_encrypt_worker+0x7c6/0xb60 [ 60.675161][ T4959] softirqs last disabled at (3641644): [] wg_packet_encrypt_worker+0xd4/0xb60 [ 60.685632][ T4959] Preemption disabled at: [ 60.685635][ T4959] [<0000000000000000>] 0x0 [ 60.694304][ T4959] CPU: 1 PID: 4959 Comm: kworker/1:4 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 60.704153][ T4959] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 60.714176][ T4959] Workqueue: events gsmld_write_task [ 60.719437][ T4959] Call Trace: [ 60.722686][ T4959] [ 60.725612][ T4959] dump_stack_lvl+0x60/0xa0 [ 60.730090][ T4959] __might_resched+0x354/0x580 [ 60.734822][ T4959] console_lock+0x11/0x60 [ 60.739116][ T4959] do_con_write+0xf2/0x19c0 [ 60.743584][ T4959] ? rcu_is_watching+0xe/0xb0 [ 60.748311][ T4959] ? rcu_is_watching+0xe/0xb0 [ 60.752951][ T4959] ? rcu_is_watching+0xe/0xb0 [ 60.757589][ T4959] ? rcu_is_watching+0xe/0xb0 [ 60.762249][ T4959] ? lock_release+0x4f7/0x670 [ 60.766905][ T4959] ? do_con_trol+0x4e60/0x4e60 [ 60.771639][ T4959] ? rcu_is_watching+0xe/0xb0 [ 60.776282][ T4959] ? lock_acquire+0x46c/0x520 [ 60.780922][ T4959] ? lock_sync+0x180/0x180 [ 60.785306][ T4959] ? do_raw_spin_lock+0x120/0x2a0 [ 60.790313][ T4959] con_write+0xb/0x20 [ 60.794262][ T4959] gsm_send_packet+0x35d/0x940 [ 60.798993][ T4959] gsmld_write_task+0x1d6/0xd60 [ 60.803868][ T4959] process_one_work+0x86e/0x1410 [ 60.808772][ T4959] ? lock_sync+0x180/0x180 [ 60.813153][ T4959] ? pwq_dec_nr_in_flight+0x230/0x230 [ 60.818492][ T4959] ? spin_bug+0x1c0/0x1c0 [ 60.822787][ T4959] worker_thread+0x5ab/0xef0 [ 60.827345][ T4959] ? process_one_work+0x1410/0x1410 [ 60.832507][ T4959] kthread+0x2e6/0x3c0 [ 60.836547][ T4959] ? kthread_complete_and_exit+0x20/0x20 [ 60.842144][ T4959] ret_from_fork+0x1f/0x30 [ 60.846618][ T4959] [ 61.673830][ T5346] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 61.683220][ T5346] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 5346, name: kworker/0:6 [ 61.692388][ T5346] preempt_count: 1, expected: 0 [ 61.697214][ T5346] RCU nest depth: 0, expected: 0 [ 61.702124][ T5346] INFO: lockdep is turned off. [ 61.706867][ T5346] irq event stamp: 2190 [ 61.710994][ T5346] hardirqs last enabled at (2189): [] _raw_spin_unlock_irq+0x1f/0x40 [ 61.720692][ T5346] hardirqs last disabled at (2190): [] __schedule+0x286a/0x57f0 [ 61.729865][ T5346] softirqs last enabled at (2186): [] do_softirq.part.0+0xde/0x130 [ 61.739470][ T5346] softirqs last disabled at (2137): [] do_softirq.part.0+0xde/0x130 [ 61.748996][ T5346] Preemption disabled at: [ 61.748999][ T5346] [<0000000000000000>] 0x0 [ 61.757695][ T5346] CPU: 0 PID: 5346 Comm: kworker/0:6 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 61.767562][ T5346] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 61.777596][ T5346] Workqueue: events gsmld_write_task [ 61.782879][ T5346] Call Trace: [ 61.786124][ T5346] [ 61.789048][ T5346] dump_stack_lvl+0x60/0xa0 [ 61.793514][ T5346] __might_resched+0x354/0x580 [ 61.798238][ T5346] console_lock+0x11/0x60 [ 61.802532][ T5346] do_con_write+0xf2/0x19c0 [ 61.807001][ T5346] ? rcu_is_watching+0xe/0xb0 [ 61.811638][ T5346] ? rcu_is_watching+0xe/0xb0 [ 61.816277][ T5346] ? rcu_is_watching+0xe/0xb0 [ 61.820911][ T5346] ? rcu_is_watching+0xe/0xb0 [ 61.825550][ T5346] ? lock_release+0x4f7/0x670 [ 61.830186][ T5346] ? do_con_trol+0x4e60/0x4e60 [ 61.834908][ T5346] ? rcu_is_watching+0xe/0xb0 [ 61.839630][ T5346] ? lock_acquire+0x46c/0x520 [ 61.844266][ T5346] ? lock_sync+0x180/0x180 [ 61.848646][ T5346] ? do_raw_spin_lock+0x120/0x2a0 [ 61.853632][ T5346] con_write+0xb/0x20 [ 61.857581][ T5346] gsm_send_packet+0x35d/0x940 [ 61.862307][ T5346] gsmld_write_task+0x1d6/0xd60 [ 61.867217][ T5346] process_one_work+0x86e/0x1410 [ 61.872114][ T5346] ? lock_sync+0x180/0x180 [ 61.876515][ T5346] ? pwq_dec_nr_in_flight+0x230/0x230 [ 61.881858][ T5346] ? spin_bug+0x1c0/0x1c0 [ 61.886146][ T5346] worker_thread+0x5ab/0xef0 [ 61.890694][ T5346] ? process_one_work+0x1410/0x1410 [ 61.895852][ T5346] kthread+0x2e6/0x3c0 [ 61.899882][ T5346] ? kthread_complete_and_exit+0x20/0x20 [ 61.905472][ T5346] ret_from_fork+0x1f/0x30 [ 61.909854][ T5346] 2023/05/08 02:39:55 executed programs: 54 [ 62.536662][ T46] Bluetooth: hci0: command 0x0419 tx timeout [ 62.690692][ T4959] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 62.700158][ T4959] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 4959, name: kworker/1:4 [ 62.709323][ T4959] preempt_count: 1, expected: 0 [ 62.714149][ T4959] RCU nest depth: 0, expected: 0 [ 62.719071][ T4959] INFO: lockdep is turned off. [ 62.723862][ T4959] irq event stamp: 3641650 [ 62.728249][ T4959] hardirqs last enabled at (3641649): [] _raw_spin_unlock_irq+0x1f/0x40 [ 62.738204][ T4959] hardirqs last disabled at (3641650): [] __schedule+0x286a/0x57f0 [ 62.747637][ T4959] softirqs last enabled at (3641646): [] wg_packet_encrypt_worker+0x7c6/0xb60 [ 62.758157][ T4959] softirqs last disabled at (3641644): [] wg_packet_encrypt_worker+0xd4/0xb60 [ 62.768541][ T4959] Preemption disabled at: [ 62.768543][ T4959] [<0000000000000000>] 0x0 [ 62.777225][ T4959] CPU: 1 PID: 4959 Comm: kworker/1:4 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 62.787266][ T4959] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 62.797637][ T4959] Workqueue: events gsmld_write_task [ 62.802893][ T4959] Call Trace: [ 62.806156][ T4959] [ 62.809059][ T4959] dump_stack_lvl+0x60/0xa0 [ 62.813524][ T4959] __might_resched+0x354/0x580 [ 62.818247][ T4959] console_lock+0x11/0x60 [ 62.822539][ T4959] do_con_write+0xf2/0x19c0 [ 62.827003][ T4959] ? rcu_is_watching+0xe/0xb0 [ 62.831643][ T4959] ? rcu_is_watching+0xe/0xb0 [ 62.836278][ T4959] ? rcu_is_watching+0xe/0xb0 [ 62.840915][ T4959] ? rcu_is_watching+0xe/0xb0 [ 62.845549][ T4959] ? lock_release+0x4f7/0x670 [ 62.850204][ T4959] ? do_con_trol+0x4e60/0x4e60 [ 62.854930][ T4959] ? rcu_is_watching+0xe/0xb0 [ 62.859911][ T4959] ? lock_acquire+0x46c/0x520 [ 62.864641][ T4959] ? lock_sync+0x180/0x180 [ 62.869017][ T4959] ? do_raw_spin_lock+0x120/0x2a0 [ 62.873999][ T4959] con_write+0xb/0x20 [ 62.877943][ T4959] gsm_send_packet+0x35d/0x940 [ 62.882671][ T4959] gsmld_write_task+0x1d6/0xd60 [ 62.887480][ T4959] process_one_work+0x86e/0x1410 [ 62.892377][ T4959] ? lock_sync+0x180/0x180 [ 62.896753][ T4959] ? pwq_dec_nr_in_flight+0x230/0x230 [ 62.902087][ T4959] ? spin_bug+0x1c0/0x1c0 [ 62.906377][ T4959] worker_thread+0x5ab/0xef0 [ 62.910927][ T4959] ? process_one_work+0x1410/0x1410 [ 62.916101][ T4959] kthread+0x2e6/0x3c0 [ 62.920128][ T4959] ? kthread_complete_and_exit+0x20/0x20 [ 62.925900][ T4959] ret_from_fork+0x1f/0x30 [ 62.930286][ T4959] [ 63.777243][ T5346] BUG: sleeping function called from invalid context at kernel/printk/printk.c:2598 [ 63.786822][ T5346] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 5346, name: kworker/0:6 [ 63.795993][ T5346] preempt_count: 1, expected: 0 [ 63.800815][ T5346] RCU nest depth: 0, expected: 0 [ 63.805855][ T5346] INFO: lockdep is turned off. [ 63.810581][ T5346] irq event stamp: 2190 [ 63.814697][ T5346] hardirqs last enabled at (2189): [] _raw_spin_unlock_irq+0x1f/0x40 [ 63.824377][ T5346] hardirqs last disabled at (2190): [] __schedule+0x286a/0x57f0 [ 63.833533][ T5346] softirqs last enabled at (2186): [] do_softirq.part.0+0xde/0x130 [ 63.843038][ T5346] softirqs last disabled at (2137): [] do_softirq.part.0+0xde/0x130 [ 63.852630][ T5346] Preemption disabled at: [ 63.852632][ T5346] [<0000000000000000>] 0x0 [ 63.861411][ T5346] CPU: 0 PID: 5346 Comm: kworker/0:6 Tainted: G W 6.4.0-rc1-syzkaller #0 [ 63.871261][ T5346] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 63.881281][ T5346] Workqueue: events gsmld_write_task [ 63.886534][ T5346] Call Trace: [ 63.889786][ T5346] [ 63.892687][ T5346] dump_stack_lvl+0x60/0xa0 [ 63.897217][ T5346] __might_resched+0x354/0x580 [ 63.901946][ T5346] ? try_to_wake_up+0xceb/0x1c40 [ 63.906848][ T5346] console_lock+0x11/0x60 [ 63.911142][ T5346] do_con_write+0xf2/0x19c0 [ 63.915612][ T5346] ? rcu_is_watching+0xe/0xb0 [ 63.920249][ T5346] ? rcu_is_watching+0xe/0xb0 [ 63.924987][ T5346] ? rcu_is_watching+0xe/0xb0 [ 63.929621][ T5346] ? rcu_is_watching+0xe/0xb0 [ 63.934255][ T5346] ? lock_release+0x4f7/0x670 [ 63.938980][ T5346] ? do_con_trol+0x4e60/0x4e60 [ 63.943707][ T5346] ? rcu_is_watching+0xe/0xb0 [ 63.948343][ T5346] ? lock_acquire+0x46c/0x520 [ 63.953003][ T5346] ? lock_sync+0x180/0x180 [ 63.957467][ T5346] ? do_raw_spin_lock+0x120/0x2a0 [ 63.962460][ T5346] con_write+0xb/0x20 [ 63.966428][ T5346] gsm_send_packet+0x35d/0x940 [ 63.971152][ T5346] gsmld_write_task+0x1d6/0xd60 [ 63.975980][ T5346] process_one_work+0x86e/0x1410 [ 63.980884][ T5346] ? lock_sync+0x180/0x180 [ 63.985273][ T5346] ? pwq_dec_nr_in_flight+0x230/0x230 [ 63.990607][ T5346] ? spin_bug+0x1c0/0x1c0 [ 63.994897][ T5346] worker_thread+0x5ab/0xef0 [ 63.999446][ T5346] ? process_one_work+0x1410/0x1410 [ 64.004604][ T5346] kthread+0x2e6/0x3c0 [ 64.008632][ T5346] ? kthread_complete_and_exit+0x20/0x20 [ 64.014311][ T5346] ret_from_fork+0x1f/0x30 [ 64.018691][ T5346]