systemd[1]: systemd-journald.service: Unit entered failed state. systemd[1]: systemd-journald.service: Failed with result 'watchdog'. systemd[1]: systemd-journald.service: Service has no hold-off time, scheduling restart. ieee802154 phy0 wpan0: encryption failed: -22 ieee802154 phy1 wpan1: encryption failed: -22 INFO: task syz-executor.4:21347 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D28648 21347 8168 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1016 [inline] __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078 tty_release_struct+0xa9/0xe0 drivers/tty/tty_io.c:1623 tty_release+0xc70/0x1210 drivers/tty/tty_io.c:1784 __fput+0x2ce/0x890 fs/file_table.c:278 task_work_run+0x148/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f9b4b62ff8b Code: Bad RIP value. RSP: 002b:00007ffff5e80a90 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000008 RCX: 00007f9b4b62ff8b RDX: 0000001b30d20000 RSI: 0000000000000000 RDI: 0000000000000007 RBP: 00007f9b4b79f980 R08: 0000000000000000 R09: 0000005e5cc27c01 R10: 0016bebdc7f40bc6 R11: 0000000000000293 R12: 00000000000590d9 R13: 00007ffff5e80b90 R14: 00007ffff5e80bb0 R15: 0000000000000032 INFO: task syz-executor.4:21366 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D28792 21366 8168 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1016 [inline] __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078 tty_release_struct+0xa9/0xe0 drivers/tty/tty_io.c:1623 tty_release+0xc70/0x1210 drivers/tty/tty_io.c:1784 __fput+0x2ce/0x890 fs/file_table.c:278 task_work_run+0x148/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f9b4b67e0d9 Code: Bad RIP value. RSP: 002b:00007f9b49bae168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: 0000000000000000 RBX: 00007f9b4b79e120 RCX: 00007f9b4b67e0d9 RDX: 00000000200005c0 RSI: 0000000000004b67 RDI: 0000000000000007 RBP: 00007f9b4b6d9ae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffff5e80a2f R14: 00007f9b49bae300 R15: 0000000000022000 INFO: task syz-executor.0:21413 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D29368 21413 8148 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1016 [inline] __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078 tty_open_by_driver drivers/tty/tty_io.c:1945 [inline] tty_open+0x387/0x990 drivers/tty/tty_io.c:2029 chrdev_open+0x266/0x770 fs/char_dev.c:423 do_dentry_open+0x4aa/0x1160 fs/open.c:796 do_last fs/namei.c:3421 [inline] path_openat+0x793/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_sys_open+0x3b3/0x520 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f32b1a93264 Code: 84 00 00 00 00 00 44 89 54 24 0c e8 96 f9 ff ff 44 8b 54 24 0c 44 89 e2 48 89 ee 41 89 c0 bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 34 44 89 c7 89 44 24 0c e8 c8 f9 ff ff 8b 44 RSP: 002b:00007f32b0052ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 00007f32b1c00f80 RCX: 00007f32b1a93264 RDX: 0000000000000002 RSI: 00007f32b0052d40 RDI: 00000000ffffff9c RBP: 00007f32b0052d40 R08: 0000000000000000 R09: 000000000000000e R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002 R13: 00007fff0e9b69df R14: 00007f32b0053300 R15: 0000000000022000 INFO: task syz-executor.3:21433 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29368 21433 8196 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1016 [inline] __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078 tty_open_by_driver drivers/tty/tty_io.c:1945 [inline] tty_open+0x387/0x990 drivers/tty/tty_io.c:2029 chrdev_open+0x266/0x770 fs/char_dev.c:423 do_dentry_open+0x4aa/0x1160 fs/open.c:796 do_last fs/namei.c:3421 [inline] path_openat+0x793/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_sys_open+0x3b3/0x520 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f8405613264 Code: Bad RIP value. RSP: 002b:00007f8403bd2ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 00007f8405780f80 RCX: 00007f8405613264 RDX: 0000000000000002 RSI: 00007f8403bd2d40 RDI: 00000000ffffff9c RBP: 00007f8403bd2d40 R08: 0000000000000000 R09: 000000000000000e R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002 R13: 00007ffc90b30d9f R14: 00007f8403bd3300 R15: 0000000000022000 Showing all locks held in the system: 2 locks held by systemd/1: 1 lock held by kthreadd/2: 3 locks held by kworker/u4:2/37: 2 locks held by kworker/1:1/52: #0: 00000000212875aa ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 #1: 00000000b0c48e6a ((work_completion)(&cgrp->release_agent_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 1 lock held by khungtaskd/1571: #0: 0000000004de7041 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441 3 locks held by kworker/0:2/3686: 3 locks held by kworker/1:2/4695: #0: 00000000212875aa ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 #1: 0000000081c9339b ((linkwatch_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 #2: 000000002f913c6a (rtnl_mutex){+.+.}, at: linkwatch_event+0xb/0x60 net/core/link_watch.c:236 1 lock held by systemd-timesyn/6165: 1 lock held by in:imklog/7806: #0: 0000000023cff9b0 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 2 locks held by agetty/7820: #0: 00000000c55c48f0 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000000cad379f (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1950 drivers/tty/n_tty.c:2154 3 locks held by sshd/8113: 1 lock held by syz-fuzzer/8144: 4 locks held by syz-executor.5/8155: #0: 00000000035fb8c2 (&hdev->req_lock){+.+.}, at: hci_dev_do_close+0x122/0x1020 net/bluetooth/hci_core.c:1629 #1: 00000000627af1a2 (&hdev->lock){+.+.}, at: hci_dev_do_close+0x343/0x1020 net/bluetooth/hci_core.c:1674 #2: 00000000657f1ae1 (hci_cb_list_lock){+.+.}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1260 [inline] #2: 00000000657f1ae1 (hci_cb_list_lock){+.+.}, at: hci_conn_hash_flush+0xda/0x260 net/bluetooth/hci_conn.c:1512 #3: 000000001c1868f4 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:297 [inline] #3: 000000001c1868f4 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x4dc/0x6f0 kernel/rcu/tree_exp.h:667 1 lock held by syz-executor.2/8171: 3 locks held by kworker/0:3/9352: #0: 00000000212875aa ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 #1: 000000009dcb8847 (deferred_process_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 #2: 000000002f913c6a (rtnl_mutex){+.+.}, at: switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:150 2 locks held by kworker/1:3/9354: #0: 00000000533812e6 ((wq_completion)"rcu_gp"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 #1: 0000000010aba775 ((work_completion)(&rew.rew_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 4 locks held by kworker/u4:8/10875: 3 locks held by kworker/u4:10/15591: 3 locks held by syz-executor.1/21353: 1 lock held by syz-executor.4/21347: #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_release_struct+0xa9/0xe0 drivers/tty/tty_io.c:1623 2 locks held by syz-executor.4/21363: 1 lock held by syz-executor.4/21366: #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_release_struct+0xa9/0xe0 drivers/tty/tty_io.c:1623 1 lock held by syz-executor.0/21413: #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_open_by_driver drivers/tty/tty_io.c:1945 [inline] #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_open+0x387/0x990 drivers/tty/tty_io.c:2029 1 lock held by syz-executor.0/21418: 1 lock held by syz-executor.3/21433: #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_open_by_driver drivers/tty/tty_io.c:1945 [inline] #0: 000000009e5c8db4 (tty_mutex){+.+.}, at: tty_open+0x387/0x990 drivers/tty/tty_io.c:2029 3 locks held by syz-executor.3/21434: 3 locks held by kworker/u4:12/21449: 2 locks held by kworker/u4:13/21450: 1 lock held by (d-rfkill)/21452: 1 lock held by kworker/u4:9/21454: 2 locks held by kworker/u4:2/21455: 1 lock held by kworker/u4:10/21457: 1 lock held by kworker/u4:0/21459: ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1571 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x991/0xe60 kernel/hung_task.c:287 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 21434 Comm: syz-executor.3 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 RIP: 0010:__lock_release kernel/locking/lockdep.c:3704 [inline] RIP: 0010:lock_release+0x304/0x8b0 kernel/locking/lockdep.c:3927 Code: 09 80 fa 03 0f 8e a4 03 00 00 66 83 68 22 10 66 f7 40 22 f0 ff 0f 85 bd 00 00 00 48 ba 00 00 00 00 00 fc ff df 48 8b 4c 24 08 <8b> 6c 24 38 48 c1 e9 03 0f b6 14 11 84 d2 74 09 80 fa 03 0f 8e 1c RSP: 0018:ffff8880ba007578 EFLAGS: 00000046 RAX: ffff888048bba9d8 RBX: ffffffff8d243760 RCX: ffff888048bba980 RDX: dffffc0000000000 RSI: ffff8880ba024cd8 RDI: ffff888048bba9fa RBP: ffff8880ba024cd8 R08: 0000000000000000 R09: 0000000000000001 R10: 0000000000000000 R11: ffffffff8c66501b R12: 1ffff11017400eb2 R13: ffffffff81542f37 R14: ffff888048bba100 R15: 0000000000000003 FS: 00007f8403bb2700(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f88d1e839f9 CR3: 0000000099f9e000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:158 [inline] _raw_spin_unlock_irqrestore+0x1b/0xe0 kernel/locking/spinlock.c:184 __run_hrtimer kernel/time/hrtimer.c:1463 [inline] __hrtimer_run_queues+0x397/0xe60 kernel/time/hrtimer.c:1527 hrtimer_interrupt+0x326/0x9e0 kernel/time/hrtimer.c:1585 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1071 [inline] smp_apic_timer_interrupt+0x10c/0x550 arch/x86/kernel/apic/apic.c:1096 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:789 [inline] RIP: 0010:lock_acquire+0x1ec/0x3c0 kernel/locking/lockdep.c:3911 Code: 08 00 00 00 00 00 00 48 c1 e8 03 80 3c 10 00 0f 85 b7 01 00 00 48 83 3d 09 2e a6 08 00 0f 84 2a 01 00 00 48 8b 7c 24 08 57 9d <0f> 1f 44 00 00 48 83 c4 18 5b 5d 41 5c 41 5d 41 5e 41 5f c3 65 8b RSP: 0018:ffff8880ba0078f8 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff13 RAX: 1ffffffff13e3051 RBX: ffff888048bba100 RCX: 6ef1e41ac93df87f RDX: dffffc0000000000 RSI: 000000009004fc4c RDI: 0000000000000286 RBP: ffffffff89f85fa0 R08: 00000000594ea6fa R09: 0000000000000001 R10: ffff888048bba9b0 R11: 0000000000074071 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000002 R15: 0000000000000000 rcu_lock_acquire include/linux/rcupdate.h:242 [inline] rcu_read_lock include/linux/rcupdate.h:627 [inline] is_bpf_text_address+0x36/0x1b0 kernel/bpf/core.c:546 kernel_text_address kernel/extable.c:152 [inline] kernel_text_address+0xbd/0xf0 kernel/extable.c:122 __kernel_text_address+0x9/0x30 kernel/extable.c:107 unwind_get_return_address arch/x86/kernel/unwind_orc.c:297 [inline] unwind_get_return_address+0x51/0x90 arch/x86/kernel/unwind_orc.c:292 __save_stack_trace+0xaf/0x190 arch/x86/kernel/stacktrace.c:45 save_stack mm/kasan/kasan.c:448 [inline] set_track mm/kasan/kasan.c:460 [inline] kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:553 kmem_cache_alloc_node+0x146/0x3b0 mm/slab.c:3649 __alloc_skb+0x71/0x560 net/core/skbuff.c:193 alloc_skb include/linux/skbuff.h:995 [inline] bcm_can_tx+0x259/0x800 net/can/bcm.c:287 bcm_tx_timeout_tsklet+0x1f0/0x3a0 net/can/bcm.c:414 tasklet_action_common.constprop.0+0x265/0x360 kernel/softirq.c:522 __do_softirq+0x265/0x980 kernel/softirq.c:292 invoke_softirq kernel/softirq.c:372 [inline] irq_exit+0x215/0x260 kernel/softirq.c:412 exiting_irq arch/x86/include/asm/apic.h:536 [inline] smp_apic_timer_interrupt+0x136/0x550 arch/x86/kernel/apic/apic.c:1098 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:789 [inline] RIP: 0010:qlink_free mm/kasan/quarantine.c:150 [inline] RIP: 0010:qlist_free_all+0xfc/0x140 mm/kasan/quarantine.c:166 Code: 50 08 48 8d 4a ff 83 e2 01 48 0f 45 c1 4c 8b 70 18 e9 40 ff ff ff e8 a3 36 cf ff 48 83 3d e3 0f 59 08 00 74 38 4c 89 ff 57 9d <0f> 1f 44 00 00 4d 85 e4 75 9e 49 c7 45 08 00 00 00 00 49 c7 45 00 RSP: 0018:ffff88804f1d79d8 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff13 RAX: 0000000000000007 RBX: ffff88808c4cfa80 RCX: 0000000000000000 RDX: 0000000000000000 RSI: ffff888048bba988 RDI: 0000000000000286 RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: ffff888046db9580 R13: ffff88804f1d7a10 R14: ffff8880b5b8fd80 R15: 0000000000000286 quarantine_reduce+0x1a9/0x230 mm/kasan/quarantine.c:259 kasan_kmalloc+0xa2/0x160 mm/kasan/kasan.c:538 slab_post_alloc_hook mm/slab.h:445 [inline] slab_alloc mm/slab.c:3397 [inline] kmem_cache_alloc_trace+0x11a/0x380 mm/slab.c:3623 kmalloc include/linux/slab.h:515 [inline] kzalloc include/linux/slab.h:709 [inline] apparmor_sk_alloc_security+0x5c/0xe0 security/apparmor/lsm.c:769 security_sk_alloc+0x50/0xb0 security/security.c:1469 sk_prot_alloc+0xf1/0x2d0 net/core/sock.c:1486 sk_alloc+0x36/0xec0 net/core/sock.c:1537 inet_create net/ipv4/af_inet.c:321 [inline] inet_create+0x369/0xdf0 net/ipv4/af_inet.c:247 __sock_create+0x3d8/0x740 net/socket.c:1365 sock_create net/socket.c:1416 [inline] __sys_socket+0xef/0x200 net/socket.c:1458 __do_sys_socket net/socket.c:1467 [inline] __se_sys_socket net/socket.c:1465 [inline] __x64_sys_socket+0x6f/0xb0 net/socket.c:1465 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f84056610d9 Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 f1 19 00 00 90 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 b8 ff ff ff f7 d8 64 89 01 48 RSP: 002b:00007f8403bb2168 EFLAGS: 00000246 ORIG_RAX: 0000000000000029 RAX: ffffffffffffffda RBX: 00007f8405781050 RCX: 00007f84056610d9 RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000002 RBP: 00007f84056bcae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffc90b30d9f R14: 00007f8403bb2300 R15: 0000000000022000