watchdog: BUG: soft lockup - CPU#0 stuck for 120s! [klogd:2388] Modules linked in: irq event stamp: 113303 hardirqs last enabled at (113302): [] seqcount_lockdep_reader_access include/linux/seqlock.h:74 [inline] hardirqs last enabled at (113302): [] read_mems_allowed_begin include/linux/cpuset.h:142 [inline] hardirqs last enabled at (113302): [] get_any_partial mm/slub.c:2662 [inline] hardirqs last enabled at (113302): [] get_partial mm/slub.c:2705 [inline] hardirqs last enabled at (113302): [] ___slab_alloc+0x112c/0x1790 mm/slub.c:3505 hardirqs last disabled at (113303): [] sysvec_apic_timer_interrupt+0xe/0xb0 arch/x86/kernel/apic/apic.c:1043 softirqs last enabled at (113222): [] softirq_handle_end kernel/softirq.c:400 [inline] softirqs last enabled at (113222): [] handle_softirqs+0x5a6/0x8e0 kernel/softirq.c:582 softirqs last disabled at (113225): [] __do_softirq kernel/softirq.c:588 [inline] softirqs last disabled at (113225): [] invoke_softirq kernel/softirq.c:428 [inline] softirqs last disabled at (113225): [] __irq_exit_rcu kernel/softirq.c:637 [inline] softirqs last disabled at (113225): [] irq_exit_rcu+0xac/0x110 kernel/softirq.c:649 CPU: 0 PID: 2388 Comm: klogd Not tainted 6.9.0-rc7-syzkaller-00158-g51474ab44abf #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024 RIP: 0010:check_kcov_mode kernel/kcov.c:173 [inline] RIP: 0010:write_comp_data+0x1f/0x90 kernel/kcov.c:236 Code: 90 90 90 90 90 90 90 90 90 90 90 49 89 d2 49 89 f8 49 89 f1 65 48 8b 15 3f ef b0 7e 65 8b 05 40 ef b0 7e a9 00 01 ff 00 74 0f c4 01 74 59 8b 82 4c 15 00 00 85 c0 74 4f 8b 82 28 15 00 00 83 RSP: 0018:ffffc900000074c0 EFLAGS: 00000206 RAX: 0000000000000101 RBX: 0000000000000007 RCX: ffffffff81151d11 RDX: ffff8881156dd700 RSI: 0000000000000008 RDI: 0000000000000001 RBP: ffffffff86c5a920 R08: 0000000000000001 R09: 0000000000000008 R10: 0000000000000009 R11: 0000000000000001 R12: 0000000000000009 R13: 0000000000000001 R14: 0000000000000008 R15: ffffc900000075ad FS: 00007f48e7366380(0000) GS:ffff8881f6400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 000055ac5f10d131 CR3: 0000000115b56000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __sanitizer_cov_trace_switch+0x54/0x90 kernel/kcov.c:341 unwind_next_frame+0x6c1/0x23a0 arch/x86/kernel/unwind_orc.c:515 arch_stack_walk+0x100/0x170 arch/x86/kernel/stacktrace.c:25 stack_trace_save+0x95/0xd0 kernel/stacktrace.c:122 save_stack+0x162/0x1f0 mm/page_owner.c:156 __set_page_owner+0x8a/0x560 mm/page_owner.c:325 set_page_owner include/linux/page_owner.h:32 [inline] post_alloc_hook+0x2d4/0x350 mm/page_alloc.c:1534 prep_new_page mm/page_alloc.c:1541 [inline] get_page_from_freelist+0x139c/0x3470 mm/page_alloc.c:3317 __alloc_pages+0x21e/0x2290 mm/page_alloc.c:4575 __alloc_pages_node include/linux/gfp.h:238 [inline] alloc_pages_node include/linux/gfp.h:261 [inline] alloc_slab_page mm/slub.c:2175 [inline] allocate_slab mm/slub.c:2338 [inline] new_slab+0xcc/0x3a0 mm/slub.c:2391 ___slab_alloc+0x66d/0x1790 mm/slub.c:3525 __slab_alloc.constprop.0+0x56/0xb0 mm/slub.c:3610 __slab_alloc_node mm/slub.c:3663 [inline] slab_alloc_node mm/slub.c:3835 [inline] __do_kmalloc_node mm/slub.c:3965 [inline] __kmalloc+0x371/0x400 mm/slub.c:3979 kmalloc include/linux/slab.h:632 [inline] usb_alloc_urb+0x69/0xa0 drivers/usb/core/urb.c:75 rx_alloc_submit+0xbd/0x150 drivers/net/usb/usbnet.c:1501 usbnet_bh+0xb97/0xd90 drivers/net/usb/usbnet.c:1571 tasklet_action_common.constprop.0+0x24c/0x3e0 kernel/softirq.c:785 handle_softirqs+0x209/0x8e0 kernel/softirq.c:554 __do_softirq kernel/softirq.c:588 [inline] invoke_softirq kernel/softirq.c:428 [inline] __irq_exit_rcu kernel/softirq.c:637 [inline] irq_exit_rcu+0xac/0x110 kernel/softirq.c:649 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1043 [inline] sysvec_apic_timer_interrupt+0x90/0xb0 arch/x86/kernel/apic/apic.c:1043 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0010:desc_read+0x13d/0x350 kernel/printk/printk_ringbuffer.c:449 Code: 1e 00 48 8b 44 24 08 48 39 c5 0f 85 da 01 00 00 e8 d8 68 1e 00 4c 89 f8 31 ff 48 c1 e8 3e 89 c6 48 89 44 24 08 e8 a3 63 1e 00 <48> 8b 44 24 08 31 d2 48 85 c0 0f 84 37 01 00 00 e8 ae 68 1e 00 48 RSP: 0018:ffffc900041efa00 EFLAGS: 00000293 RAX: 0000000000000000 RBX: ffffffff884817b0 RCX: ffffffff8134748d RDX: ffff8881156dd700 RSI: 0000000000000000 RDI: 0000000000000005 RBP: 0000000100004a82 R08: 0000000000000005 R09: 0000000000000000 R10: 0000000000000003 R11: 0000000000152840 R12: ffffc900041efb18 R13: ffffc900041efaf8 R14: ffffffff883fb810 R15: c000000100004a82 prb_first_seq kernel/printk/printk_ringbuffer.c:1957 [inline] _prb_read_valid+0x535/0x7e0 kernel/printk/printk_ringbuffer.c:2114 prb_read_valid+0x79/0xb0 kernel/printk/printk_ringbuffer.c:2182 syslog_print+0x44f/0x5d0 kernel/printk/printk.c:1599 do_syslog+0x3be/0x6a0 kernel/printk/printk.c:1734 __do_sys_syslog kernel/printk/printk.c:1826 [inline] __se_sys_syslog kernel/printk/printk.c:1824 [inline] __x64_sys_syslog+0x74/0xb0 kernel/printk/printk.c:1824 do_syscall_x64 arch/x86/entry/common.c:52 [inline] do_syscall_64+0xcf/0x260 arch/x86/entry/common.c:83 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f48e74c7fa7 Code: 73 01 c3 48 8b 0d 81 ce 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 b8 67 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 51 ce 0c 00 f7 d8 64 89 01 48 RSP: 002b:00007ffd63f602c8 EFLAGS: 00000206 ORIG_RAX: 0000000000000067 RAX: ffffffffffffffda RBX: 00007f48e76664a0 RCX: 00007f48e74c7fa7 RDX: 00000000000003ff RSI: 00007f48e76664a0 RDI: 0000000000000002 RBP: 0000000000000000 R08: 0000000000000007 R09: c1dd1740e6f12767 R10: 0000000000004000 R11: 0000000000000206 R12: 00007f48e76664a0 R13: 00007f48e7656212 R14: 00007f48e766689e R15: 00007f48e766689e Sending NMI from CPU 0 to CPUs 1: cdc_wdm 2-1:1.0: wdm_int_callback - 0 bytes NMI backtrace for cpu 1 CPU: 1 PID: 2381 Comm: syslogd Not tainted 6.9.0-rc7-syzkaller-00158-g51474ab44abf #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024 RIP: 0010:number+0x998/0xb80 lib/vsprintf.c:511 Code: ff ff e8 eb de cc fa 83 6c 24 18 01 c6 44 24 34 2b e9 38 f8 ff ff c6 44 24 34 2d e9 4d f8 ff ff 4c 8b 64 24 10 e9 bc fa ff ff c3 de cc fa 48 8b 2c 24 4c 89 e6 48 89 ef e8 84 f5 ff ff 48 29 RSP: 0000:ffffc900001a7ad8 EFLAGS: 00000046 RAX: 0000000000000000 RBX: ffffc900001a7eb1 RCX: ffffffff8685f6ff RDX: ffff8881156d9d00 RSI: 000000000000000a RDI: 0000000000000001 RBP: 000000000000000a R08: 0000000000000001 R09: 000000000000000a R10: 000000000000000a R11: 00000000001ce8d0 R12: 000000000000014e R13: 000000000000000a R14: ffffc900801a7eaf R15: 0000000000000000 FS: 00007f4ddc3f7380(0000) GS:ffff8881f6500000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f7155577000 CR3: 0000000115846000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: vsnprintf+0x92a/0x1880 lib/vsprintf.c:2890 sprintf+0xcd/0x110 lib/vsprintf.c:3028 print_time kernel/printk/printk.c:1330 [inline] info_print_prefix+0x25c/0x350 kernel/printk/printk.c:1356 record_print_text+0x141/0x400 kernel/printk/printk.c:1405 printk_get_next_message+0x2a6/0x670 kernel/printk/printk.c:2840 console_emit_next_record kernel/printk/printk.c:2880 [inline] console_flush_all+0x3b2/0xd70 kernel/printk/printk.c:2979 console_unlock+0xae/0x290 kernel/printk/printk.c:3048 vprintk_emit kernel/printk/printk.c:2348 [inline] vprintk_emit+0x11a/0x5a0 kernel/printk/printk.c:2303 dev_vprintk_emit drivers/base/core.c:4950 [inline] dev_printk_emit+0xfb/0x140 drivers/base/core.c:4961 __dev_printk+0xf5/0x270 drivers/base/core.c:4973 _dev_err+0xe5/0x120 drivers/base/core.c:5016 wdm_int_callback+0x7d1/0xaa0 drivers/usb/class/cdc-wdm.c:276 __usb_hcd_giveback_urb+0x364/0x5c0 drivers/usb/core/hcd.c:1648 usb_hcd_giveback_urb+0x396/0x450 drivers/usb/core/hcd.c:1732 dummy_timer+0x17f6/0x3900 drivers/usb/gadget/udc/dummy_hcd.c:1987 __run_hrtimer kernel/time/hrtimer.c:1692 [inline] __hrtimer_run_queues+0x20c/0xcc0 kernel/time/hrtimer.c:1756 hrtimer_interrupt+0x31b/0x800 kernel/time/hrtimer.c:1818 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1032 [inline] __sysvec_apic_timer_interrupt+0x10f/0x450 arch/x86/kernel/apic/apic.c:1049 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1043 [inline] sysvec_apic_timer_interrupt+0x3e/0xb0 arch/x86/kernel/apic/apic.c:1043 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline] RIP: 0010:_raw_spin_unlock_irqrestore+0x31/0x80 kernel/locking/spinlock.c:194 Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 56 4b a1 fa 48 89 df e8 ae c7 a1 fa f7 c5 00 02 00 00 75 23 9c 58 f6 c4 02 75 37 01 00 00 00 e8 85 35 96 fa 65 8b 05 d6 db 73 79 85 c0 74 16 5b RSP: 0000:ffffc900001a8ad8 EFLAGS: 00000246 RAX: 0000000000000002 RBX: ffff8881f652a640 RCX: 1ffffffff1955ed8 RDX: 0000000000000000 RSI: ffffffff86c7cf00 RDI: ffffffff86e73ce0 RBP: 0000000000000246 R08: 0000000000000001 R09: fffffbfff194f3b5 R10: ffffffff8ca79daf R11: ffffffff86ca4000 R12: 0000000100000cb1 R13: 0000000000000000 R14: ffff8881f652a640 R15: 00000000ffffffff __mod_timer+0x8f6/0xdc0 kernel/time/timer.c:1187 sk_reset_timer+0x21/0xc0 net/core/sock.c:3420 tcp_keepalive_timer+0x46e/0xee0 net/ipv4/tcp_timer.c:752 call_timer_fn+0x1a0/0x610 kernel/time/timer.c:1793 expire_timers kernel/time/timer.c:1844 [inline] __run_timers+0x74b/0xaf0 kernel/time/timer.c:2418 __run_timer_base kernel/time/timer.c:2429 [inline] __run_timer_base kernel/time/timer.c:2422 [inline] run_timer_base+0x111/0x190 kernel/time/timer.c:2438 run_timer_softirq+0x1a/0x40 kernel/time/timer.c:2448 handle_softirqs+0x209/0x8e0 kernel/softirq.c:554 __do_softirq kernel/softirq.c:588 [inline] invoke_softirq kernel/softirq.c:428 [inline] __irq_exit_rcu kernel/softirq.c:637 [inline] irq_exit_rcu+0xac/0x110 kernel/softirq.c:649 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1043 [inline] sysvec_apic_timer_interrupt+0x90/0xb0 arch/x86/kernel/apic/apic.c:1043 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0010:finish_task_switch.isra.0+0x1e5/0xa40 kernel/sched/core.c:5283 Code: 0f 85 ad 07 00 00 8b 0d a1 3e 74 08 85 c9 0f 85 cb 02 00 00 48 89 df e8 29 43 69 05 e8 b4 48 33 00 fb 65 48 8b 1d 2b 20 dd 7e <48> 8d bb 28 15 00 00 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 RSP: 0000:ffffc9000172fd80 EFLAGS: 00000206 RAX: 000000000000dd99 RBX: ffff8881156d9d00 RCX: 1ffffffff1335349 RDX: 0000000000000000 RSI: ffffffff86c7cf00 RDI: ffffffff86e73ce0 RBP: ffffc9000172fdc8 R08: 0000000000000001 R09: 0000000000000001 R10: ffffffff899ad3d7 R11: 0000000000000000 R12: ffff8881f653d898 R13: ffff8881123d1d00 R14: ffff888102ece5c0 R15: ffff8881f653d898 context_switch kernel/sched/core.c:5412 [inline] __schedule+0xcae/0x3170 kernel/sched/core.c:6746 __schedule_loop kernel/sched/core.c:6823 [inline] schedule+0xe7/0x350 kernel/sched/core.c:6838 exit_to_user_mode_loop kernel/entry/common.c:102 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:328 [inline] irqentry_exit_to_user_mode+0xd5/0x240 kernel/entry/common.c:231 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0033:0x7f4ddc684fd3 Code: 00 3b 43 18 0f 83 25 01 00 00 44 8b 7b 28 45 85 ff 0f 85 8f 00 00 00 48 8b 3b e8 28 f2 fb ff 8b 7b 08 e8 90 f8 fb ff 48 8b 3b b6 01 00 00 be 41 0d 00 00 31 c0 e8 3c 01 fc ff 89 43 08 89 c7 RSP: 002b:00007ffd688c4c30 EFLAGS: 00000207 RAX: 0000000000000000 RBX: 00005563b6ed1910 RCX: 00007f4ddc54c0a8 RDX: 00007f4ddc6fa080 RSI: 00007f4ddc6ea30a RDI: 00007f4ddc6ea443 RBP: 00007ffd688c4d30 R08: 0000000000000001 R09: 0000000000000000 R10: 00007f4ddc6ea3a3 R11: 0000000000000246 R12: 00005563b6ed1c50 R13: 00000000664c2e41 R14: 0000000000000006 R15: 00005563b6ed1a60