ci-upstream-kasan-gce/strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ci-upstream-kasan-gce/syz-executor644004882 <...> Warning: Permanently added '10.128.0.233' (ED25519) to the list of known hosts. execve("ci-upstream-kasan-gce/syz-executor644004882", ["ci-upstream-kasan-gce/syz-executor644004882"], 0x7ffe92bd1720 /* 10 vars */) = 0 brk(NULL) = 0x55559301c000 brk(0x55559301cd80) = 0x55559301cd80 arch_prctl(ARCH_SET_FS, 0x55559301c400) = 0 set_tid_address(0x55559301c6d0) = 5639 set_robust_list(0x55559301c6e0, 24) = 0 rseq({cpu_id_start=0, cpu_id=RSEQ_CPU_ID_UNINITIALIZED, rseq_cs=NULL, flags=0, node_id=0, mm_cid=0, slice_ctrl={request=0, granted=0, __reserved=0}, __reserved=0}, 33, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlinkat(AT_FDCWD, "/proc/self/exe", "/root/ci-upstream-kasan-gce/syz-executor644004882", 4096) = 49 getrandom("\x6e\x97\x8f\xe4\x57\x4b\xd4\xb6", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55559301cd80 brk(0x55559303dd80) = 0x55559303dd80 brk(0x55559303e000) = 0x55559303e000 mprotect(0x7f0155088000, 20480, PROT_READ) = 0 mmap(0x1ffffffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffffffff000 mmap(0x200000000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200000000000 mmap(0x200001000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200001000000 rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDci-upstream-kasan-gce/strace-static-x86_64: Process 5640 attached , child_tidptr=0x55559301c6d0) = 5640 [pid 5640] set_robust_list(0x55559301c6e0, 24) = 0 [pid 5639] rt_sigprocmask(SIG_SETMASK, [] [pid 5640] rt_sigprocmask(SIG_SETMASK, [] [pid 5639] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5640] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5640] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5640] setpgid(0, 0) = 0 [pid 5640] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5640] write(3, "1000", 4) = 4 [pid 5640] close(3) = 0 executing program [pid 5640] write(1, "executing program\n", 18) = 18 [pid 5640] openat(AT_FDCWD, "/dev/raw-gadget", O_RDWR) = 3 [pid 5640] ioctl(3, USB_RAW_IOCTL_INIT, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, UI_DEV_CREATE or USB_RAW_IOCTL_RUN, 0) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 18 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [ 86.688759][ T189] usb 1-1: new high-speed USB device number 2 using dummy_hcd [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 18 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 9 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 46 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_VBUS_DRAW, 0) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_CONFIGURE, 0) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb4c) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb5c) = 1 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb6c) = 12 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb7c) = 11 [ 86.867887][ T189] usb 1-1: New USB device found, idVendor=0424, idProduct=012c, bcdDevice= 0.00 [ 86.878492][ T189] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_READ, 0x7ffc2669f8f0) = 0 [ 86.935352][ T189] usb 1-1: probing VID:PID(0424:012C) [ 86.954993][ T189] usb 1-1: vub300 testing BULK IN EndPoint(0) 81 [ 86.968502][ T189] usb 1-1: vub300 testing BULK OUT EndPoint(1) 02 [ 86.988503][ T189] usb 1-1: vub300 testing BULK IN EndPoint(2) 83 [ 86.994934][ T189] usb 1-1: vub300 testing BULK OUT EndPoint(3) 04 [ 87.008493][ T189] usb 1-1: vub300 LARGE packets using EndPoints 02 81 04 83 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0920) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f910) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0920) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_READ, 0x7ffc2669f910) = 0 [ 87.365793][ T189] usb 1-1: operating_mode = IRQs 4-bit 48 MHz with 512 byte USB packets [pid 5640] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0920) = 0 [pid 5640] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f910) = 15 [ 87.577798][ T189] usb 1-1: USB vub300 remote SDIO host controller[0]connected with SD/SDIO card inserted [pid 5640] exit_group(0) = ? [pid 5640] +++ exited with 0 +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5640, si_uid=0, si_status=0, si_utime=0, si_stime=2 /* 0.02 s */} --- restart_syscall(<... resuming interrupted rt_sigprocmask ...>) = 0 rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDci-upstream-kasan-gce/strace-static-x86_64: Process 5645 attached [pid 5645] set_robust_list(0x55559301c6e0, 24 [pid 5639] <... clone resumed>, child_tidptr=0x55559301c6d0) = 5645 [pid 5645] <... set_robust_list resumed>) = 0 [pid 5645] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5639] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5645] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5645] setpgid(0, 0) = 0 [pid 5645] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5645] write(3, "1000", 4) = 4 [pid 5645] close(3) = 0 executing program [pid 5645] write(1, "executing program\n", 18) = 18 [pid 5645] openat(AT_FDCWD, "/dev/raw-gadget", O_RDWR) = 3 [pid 5645] ioctl(3, USB_RAW_IOCTL_INIT, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, UI_DEV_CREATE or USB_RAW_IOCTL_RUN, 0) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [ 88.422090][ T189] usb 1-1: SET_CLOCK_SPEED 200kHz failed with retval=-71 [ 88.448280][ T5358] usb 1-1: SET_CLOCK_SPEED 200kHz failed with retval=-71 [ 88.461340][ T189] usb 1-1: USB disconnect, device number 2 [ 88.470383][ T5358] usb 1-1: SET_CLOCK_SPEED 200kHz failed with retval=-19 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 18 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [ 88.547672][ T189] USB vub300 remote SDIO host controller[0] now disconnected [ 88.838576][ T189] usb 1-1: new high-speed USB device number 3 using dummy_hcd [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 18 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 9 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f8f0) = 46 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0900) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_VBUS_DRAW, 0) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_CONFIGURE, 0) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb4c) = 0 [ 89.032176][ T189] usb 1-1: New USB device found, idVendor=0424, idProduct=012c, bcdDevice= 0.00 [ 89.041347][ T189] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb5c) = 1 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb6c) = 12 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP_ENABLE, 0x7f015508eb7c) = 11 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_READ, 0x7ffc2669f8f0) = 0 [ 89.122526][ T189] usb 1-1: probing VID:PID(0424:012C) [ 89.129638][ T189] usb 1-1: vub300 testing BULK IN EndPoint(0) 81 [ 89.136069][ T189] usb 1-1: vub300 testing BULK OUT EndPoint(1) 02 [ 89.142625][ T189] usb 1-1: vub300 testing BULK IN EndPoint(2) 83 [ 89.149111][ T189] usb 1-1: vub300 testing BULK OUT EndPoint(3) 04 [ 89.155583][ T189] usb 1-1: vub300 LARGE packets using EndPoints 02 81 04 83 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0920) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EP0_WRITE, 0x7ffc2669f910) = 0 [pid 5645] ioctl(3, USB_RAW_IOCTL_EVENT_FETCH, 0x7ffc266a0920) = 0 [ 89.499129][ C0] BUG: sleeping function called from invalid context at kernel/workqueue.c:4487 [ 89.508825][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 15, name: ksoftirqd/0 [ 89.517813][ C0] preempt_count: 100, expected: 0 [ 89.522927][ C0] RCU nest depth: 0, expected: 0 [ 89.527937][ C0] 1 lock held by ksoftirqd/0/15: [ 89.532953][ C0] #0: ffffc90000147a80 ((&vub300->inactivity_timer)){+.-.}-{0:0}, at: call_timer_fn+0xd4/0x5e0 [ 89.543603][ C0] Preemption disabled at: [ 89.543614][ C0] [] handle_softirqs+0xab/0x840 [ 89.554459][ C0] CPU: 0 UID: 0 PID: 15 Comm: ksoftirqd/0 Not tainted syzkaller #0 PREEMPT(full) [ 89.554483][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026 [ 89.554503][ C0] Call Trace: [ 89.554511][ C0] [ 89.554519][ C0] dump_stack_lvl+0xe8/0x150 [ 89.554554][ C0] __might_resched+0x378/0x4d0 [ 89.554586][ C0] ? handle_softirqs+0xab/0x840 [ 89.554615][ C0] __cancel_work_sync+0x6d/0x110 [ 89.554648][ C0] mmc_free_host+0x19/0x30 [ 89.554695][ C0] call_timer_fn+0x192/0x5e0 [ 89.554718][ C0] ? __pfx_vub300_inactivity_timer_expired+0x10/0x10 [ 89.554746][ C0] ? call_timer_fn+0xd4/0x5e0 [ 89.554765][ C0] ? __pfx_call_timer_fn+0x10/0x10 [ 89.554797][ C0] ? _raw_spin_unlock_irq+0x23/0x50 [ 89.554822][ C0] ? __pfx_vub300_inactivity_timer_expired+0x10/0x10 [ 89.554852][ C0] __run_timer_base+0x652/0x8b0 [ 89.554900][ C0] ? __pfx___run_timer_base+0x10/0x10 [ 89.554948][ C0] run_timer_softirq+0xb7/0x170 [ 89.554981][ C0] handle_softirqs+0x225/0x840 [ 89.555011][ C0] ? run_ksoftirqd+0x36/0x60 [ 89.555048][ C0] run_ksoftirqd+0x36/0x60 [ 89.555076][ C0] smpboot_thread_fn+0x57c/0xa80 [ 89.555107][ C0] ? smpboot_thread_fn+0x4e/0xa80 [ 89.555143][ C0] kthread+0x388/0x470 [ 89.555173][ C0] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 89.555198][ C0] ? __pfx_kthread+0x10/0x10 [ 89.555230][ C0] ret_from_fork+0x514/0xb70 [ 89.555267][ C0] ? __pfx_ret_from_fork+0x10/0x10 [ 89.555299][ C0] ? __switch_to+0xc89/0x1420 [ 89.555331][ C0] ? __pfx_kthread+0x10/0x10 [ 89.555364][ C0] ret_from_fork_asm+0x1a/0x30 [ 89.555403][ C0] [ 89.717457][ C0] BUG: scheduling while atomic: ksoftirqd/0/15/0x00000101 [ 89.724676][ C0] 1 lock held by ksoftirqd/0/15: [ 89.729722][ C0] #0: ffffc90000147a80 ((&vub300->inactivity_timer)){+.-.}-{0:0}, at: call_timer_fn+0xd4/0x5e0 [ 89.740268][ C0] Modules linked in: [ 89.744315][ C0] Preemption disabled at: [ 89.744327][ C0] [] handle_softirqs+0xab/0x840 [ 89.755203][ C0] Kernel panic - not syncing: scheduling while atomic: panic_on_warn set ... [ 89.763967][ C0] CPU: 0 UID: 0 PID: 15 Comm: ksoftirqd/0 Tainted: G W syzkaller #0 PREEMPT(full) [ 89.774735][ C0] Tainted: [W]=WARN [ 89.778547][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026 [ 89.788631][ C0] Call Trace: [ 89.791916][ C0] [ 89.794851][ C0] vpanic+0x56c/0xa60 [ 89.798856][ C0] ? __pfx_vpanic+0x10/0x10 [ 89.803386][ C0] panic+0xc5/0xd0 [ 89.807122][ C0] ? __pfx_panic+0x10/0x10 [ 89.811564][ C0] ? __pfx__printk+0x10/0x10 [ 89.816184][ C0] ? print_lock_name+0x68/0x90 [ 89.820958][ C0] ? handle_softirqs+0xab/0x840 [ 89.825819][ C0] check_panic_on_warn+0x89/0xb0 [ 89.830780][ C0] ? handle_softirqs+0xab/0x840 [ 89.835659][ C0] __schedule_bug+0xf6/0x150 [ 89.840305][ C0] __schedule+0x189d/0x56c0 [ 89.844837][ C0] ? __lock_acquire+0x683/0x2cf0 [ 89.849789][ C0] ? stack_trace_save+0xa9/0x100 [ 89.854742][ C0] ? check_path+0x21/0x40 [ 89.859078][ C0] ? check_noncircular+0xda/0x150 [ 89.864121][ C0] ? __pfx___schedule+0x10/0x10 [ 89.868991][ C0] ? lock_acquire+0x106/0x350 [ 89.873696][ C0] ? schedule+0x90/0x2b0 [ 89.877959][ C0] schedule+0x164/0x2b0 [ 89.882154][ C0] schedule_timeout+0xc0/0x2c0 [ 89.886927][ C0] ? __pfx_schedule_timeout+0x10/0x10 [ 89.892310][ C0] ? do_raw_spin_lock+0x12b/0x2f0 [ 89.897367][ C0] ? _raw_spin_unlock_irq+0x23/0x50 [ 89.902585][ C0] ? wait_for_completion+0x272/0x5e0 [ 89.907901][ C0] wait_for_completion+0x2ca/0x5e0 [ 89.913075][ C0] ? __pfx_wait_for_completion+0x10/0x10 [ 89.918745][ C0] __synchronize_srcu+0x23b/0x2f0 [ 89.923828][ C0] ? __pfx___synchronize_srcu+0x10/0x10 [ 89.929414][ C0] ? do_raw_spin_lock+0x12b/0x2f0 [ 89.934463][ C0] ? __pfx_wakeme_after_rcu+0x10/0x10 [ 89.939869][ C0] ? _raw_spin_unlock_irqrestore+0x30/0x80 [ 89.945698][ C0] ? ktime_get_mono_fast_ns+0x2d2/0x2f0 [ 89.951271][ C0] ? synchronize_srcu+0x20a/0x260 [ 89.956321][ C0] wakeup_source_unregister+0x129/0x3f0 [ 89.961901][ C0] mmc_host_classdev_release+0x47/0x100 [ 89.967473][ C0] ? __pfx_mmc_host_classdev_release+0x10/0x10 [ 89.973672][ C0] device_release+0xc4/0x1f0 [ 89.978293][ C0] kobject_put+0x222/0x550 [ 89.982743][ C0] ? mmc_pwrseq_free+0x86/0xa0 [ 89.987530][ C0] call_timer_fn+0x192/0x5e0 [ 89.992134][ C0] ? __pfx_vub300_inactivity_timer_expired+0x10/0x10 [ 89.998828][ C0] ? call_timer_fn+0xd4/0x5e0 [ 90.003523][ C0] ? __pfx_call_timer_fn+0x10/0x10 [ 90.008654][ C0] ? _raw_spin_unlock_irq+0x23/0x50 [ 90.013867][ C0] ? __pfx_vub300_inactivity_timer_expired+0x10/0x10 [ 90.020565][ C0] __run_timer_base+0x652/0x8b0 [ 90.025451][ C0] ? __pfx___run_timer_base+0x10/0x10 [ 90.030861][ C0] run_timer_softirq+0xb7/0x170 [ 90.035740][ C0] handle_softirqs+0x225/0x840 [ 90.040528][ C0] ? run_ksoftirqd+0x36/0x60 [ 90.045150][ C0] run_ksoftirqd+0x36/0x60 [ 90.049595][ C0] smpboot_thread_fn+0x57c/0xa80 [ 90.054563][ C0] ? smpboot_thread_fn+0x4e/0xa80 [ 90.059614][ C0] kthread+0x388/0x470 [ 90.063729][ C0] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 90.069212][ C0] ? __pfx_kthread+0x10/0x10 [ 90.073834][ C0] ret_from_fork+0x514/0xb70 [ 90.078462][ C0] ? __pfx_ret_from_fork+0x10/0x10 [ 90.083602][ C0] ? __switch_to+0xc89/0x1420 [ 90.088309][ C0] ? __pfx_kthread+0x10/0x10 [ 90.092932][ C0] ret_from_fork_asm+0x1a/0x30 [ 90.097731][ C0] [ 90.101365][ C0] Kernel Offset: disabled [ 90.105703][ C0] Rebooting in 86400 seconds..