Starting Update UTMP about System Runlevel Changes... [ OK ] Started Load/Save RF Kill Switch Status. [ OK ] Started Update UTMP about System Runlevel Changes. [ 13.843531][ C1] random: crng init done [ 13.847882][ C1] random: 7 urandom warning(s) missed due to ratelimiting Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.1.16' (ECDSA) to the list of known hosts. 2020/04/09 13:35:51 parsed 1 programs 2020/04/09 13:35:53 executed programs: 0 syzkaller login: [ 1025.094492][ T381] cgroup: Unknown subsys name 'perf_event' [ 1025.103231][ T381] cgroup: Unknown subsys name 'net_cls' [ 1027.658808][ T352] usb 1-1: new high-speed USB device number 2 using dummy_hcd [ 1027.758903][ T352] usb 1-1: Using ep0 maxpacket: 8 [ 1027.888747][ T352] usb 1-1: config 118 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 1027.903807][ T352] usb 1-1: New USB device found, idVendor=03f6, idProduct=4200, bcdDevice=42.ef [ 1027.917135][ T352] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 1027.970626][ T352] hub 1-1:118.0: bad descriptor, ignoring hub [ 1027.983500][ T352] hub: probe of 1-1:118.0 failed with error -5 [ 1027.997924][ T352] cdc_wdm 1-1:118.0: cdc-wdm0: USB WDM device [ 1028.930468][ T344] usb 1-1: USB disconnect, device number 2 [ 1029.718392][ T344] usb 1-1: new high-speed USB device number 3 using dummy_hcd [ 1029.818373][ T344] usb 1-1: Using ep0 maxpacket: 8 [ 1029.948457][ T344] usb 1-1: config 118 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 1029.959865][ T344] usb 1-1: New USB device found, idVendor=03f6, idProduct=4200, bcdDevice=42.ef [ 1029.969554][ T344] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 1030.018913][ T344] hub 1-1:118.0: bad descriptor, ignoring hub [ 1030.025423][ T344] hub: probe of 1-1:118.0 failed with error -5 [ 1030.034208][ T344] cdc_wdm 1-1:118.0: cdc-wdm0: USB WDM device 2020/04/09 13:35:58 executed programs: 1 [ 1030.718517][ T154] usb 1-1: reset high-speed USB device number 3 using dummy_hcd [ 1030.818262][ T154] usb 1-1: Using ep0 maxpacket: 8 [ 1031.908826][ T344] usb 1-1: USB disconnect, device number 3 [ 1032.707951][ T154] usb 1-1: new high-speed USB device number 4 using dummy_hcd [ 1032.808136][ T154] usb 1-1: Using ep0 maxpacket: 8 [ 1032.938001][ T154] usb 1-1: config 118 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 1032.949194][ T154] usb 1-1: New USB device found, idVendor=03f6, idProduct=4200, bcdDevice=42.ef [ 1032.958293][ T154] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 1033.008510][ T154] hub 1-1:118.0: bad descriptor, ignoring hub [ 1033.014811][ T154] hub: probe of 1-1:118.0 failed with error -5 [ 1033.028463][ T154] cdc_wdm 1-1:118.0: cdc-wdm0: USB WDM device [ 1033.868003][ T344] usb 1-1: reset high-speed USB device number 4 using dummy_hcd [ 1033.957997][ T344] usb 1-1: Using ep0 maxpacket: 8 [ 1035.038451][ T154] usb 1-1: USB disconnect, device number 4 [ 1035.837616][ T344] usb 1-1: new high-speed USB device number 5 using dummy_hcd [ 1035.937642][ T344] usb 1-1: Using ep0 maxpacket: 8 [ 1036.067683][ T344] usb 1-1: config 118 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 1036.080061][ T344] usb 1-1: New USB device found, idVendor=03f6, idProduct=4200, bcdDevice=42.ef [ 1036.089144][ T344] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 1036.138187][ T344] hub 1-1:118.0: bad descriptor, ignoring hub [ 1036.144545][ T344] hub: probe of 1-1:118.0 failed with error -5 [ 1036.153374][ T344] cdc_wdm 1-1:118.0: cdc-wdm0: USB WDM device 2020/04/09 13:37:01 executed programs: 3 2020/04/09 13:37:01 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe [ 1093.684545][ T882] cgroup: Unknown subsys name 'perf_event' [ 1093.690740][ T882] cgroup: Unknown subsys name 'net_cls' [ 1095.677938][ T1330] udc-core: couldn't find an available UDC or it's busy [ 1095.685882][ T1330] misc raw-gadget: fail, usb_gadget_probe_driver returned -16 2020/04/09 13:38:03 executed programs: 5 2020/04/09 13:38:03 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe [ 1155.684384][ T1334] cgroup: Unknown subsys name 'perf_event' [ 1155.692503][ T1334] cgroup: Unknown subsys name 'net_cls' [ 1157.692888][ T1782] udc-core: couldn't find an available UDC or it's busy [ 1157.700123][ T1782] misc raw-gadget: fail, usb_gadget_probe_driver returned -16 [ 1190.422162][ T23] INFO: task syz-executor.0:867 blocked for more than 143 seconds. [ 1190.430428][ T23] Not tainted 5.6.0-rc7-syzkaller #0 [ 1190.436381][ T23] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1190.445222][ T23] syz-executor.0 D25984 867 381 0x80004006 [ 1190.451584][ T23] Call Trace: [ 1190.455022][ T23] ? __schedule+0x892/0x1d80 [ 1190.459622][ T23] ? __sched_text_start+0x8/0x8 [ 1190.464612][ T23] ? prepare_to_wait_event+0x129/0x650 [ 1190.470130][ T23] ? _raw_spin_unlock_irqrestore+0x39/0x40 [ 1190.475991][ T23] schedule+0xcd/0x2b0 [ 1190.480093][ T23] wdm_flush+0x2ea/0x3c0 [ 1190.484418][ T23] ? wdm_poll+0x280/0x280 [ 1190.488797][ T23] ? __kasan_slab_free+0x12e/0x160 [ 1190.493974][ T23] ? finish_wait+0x260/0x260 [ 1190.498570][ T23] ? task_work_add+0x97/0x120 [ 1190.503294][ T23] ? wdm_poll+0x280/0x280 [ 1190.507659][ T23] filp_close+0xb4/0x160 [ 1190.512091][ T23] put_files_struct+0x1d8/0x2e0 [ 1190.517077][ T23] exit_files+0x7e/0xa0 [ 1190.522181][ T23] do_exit+0xb36/0x2c80 [ 1190.526624][ T23] ? find_held_lock+0x2d/0x110 [ 1190.531376][ T23] ? mm_update_next_owner+0x7a0/0x7a0 [ 1190.537042][ T23] ? lock_downgrade+0x6e0/0x6e0 [ 1190.542060][ T23] do_group_exit+0x125/0x340 [ 1190.546659][ T23] get_signal+0x480/0x2470 [ 1190.551078][ T23] ? rcu_read_lock_bh_held+0xb0/0xb0 [ 1190.556443][ T23] do_signal+0x88/0x1490 [ 1190.560711][ T23] ? putname+0xe1/0x120 [ 1190.564933][ T23] ? do_sys_openat2+0x43f/0x740 [ 1190.569792][ T23] ? setup_sigcontext+0x820/0x820 [ 1190.575538][ T23] ? _copy_to_user+0x107/0x150 [ 1190.580330][ T23] ? put_timespec64+0xcb/0x120 [ 1190.585164][ T23] ? ns_to_kernel_old_timeval+0x100/0x100 [ 1190.590890][ T23] ? do_sys_open+0xc3/0x140 [ 1190.595529][ T23] ? filp_open+0x70/0x70 [ 1190.599808][ T23] exit_to_usermode_loop+0x1a2/0x200 [ 1190.605237][ T23] do_syscall_64+0x4e0/0x5a0 [ 1190.609907][ T23] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 1190.615996][ T23] RIP: 0033:0x416621 [ 1190.620034][ T23] Code: 48 09 c8 0f 57 d2 f2 48 0f 2a d0 f2 0f 58 d2 e9 2d fc ff ff 48 89 c1 48 83 e0 01 48 d1 e9 48 09 c8 0f 57 c9 f2 48 0f 2a c8 f2 <0f> 58 c9 e9 eb fb ff ff f2 0f 10 05 df 7e 71 01 f2 0f 11 84 24 90 [ 1190.639795][ T23] RSP: 002b:00007f44ace097a0 EFLAGS: 00000293 ORIG_RAX: 0000000000000002 [ 1190.648287][ T23] RAX: 0000000000000004 RBX: 00007f44ace0a6d4 RCX: 0000000000416621 [ 1190.657562][ T23] RDX: 0000000000000000 RSI: 0000000000000002 RDI: 00007f44ace097d0 [ 1190.665774][ T23] RBP: 000000000076bf00 R08: 0000000000000000 R09: 000000000000000f [ 1190.674161][ T23] R10: 0000000000000064 R11: 0000000000000293 R12: 00000000ffffffff [ 1190.682818][ T23] R13: 0000000000000bf3 R14: 00000000004ce1c4 R15: 000000000076bf0c [ 1190.690938][ T23] [ 1190.690938][ T23] Showing all locks held in the system: [ 1190.699130][ T23] 1 lock held by khungtaskd/23: [ 1190.704135][ T23] #0: ffffffff87108b60 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x264 [ 1190.713552][ T23] 1 lock held by in:imklog/260: [ 1190.718595][ T23] #0: ffff8881c64865e0 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xe3/0x100 [ 1190.727258][ T23] [ 1190.729590][ T23] ============================================= [ 1190.729590][ T23] [ 1190.738059][ T23] NMI backtrace for cpu 0 [ 1190.742579][ T23] CPU: 0 PID: 23 Comm: khungtaskd Not tainted 5.6.0-rc7-syzkaller #0 [ 1190.750886][ T23] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1190.762088][ T23] Call Trace: [ 1190.765379][ T23] dump_stack+0xef/0x16e [ 1190.769614][ T23] ? lapic_can_unplug_cpu.cold+0xc/0x3b [ 1190.775138][ T23] nmi_cpu_backtrace.cold+0x70/0xb1 [ 1190.780506][ T23] ? lapic_can_unplug_cpu.cold+0x3b/0x3b [ 1190.786686][ T23] nmi_trigger_cpumask_backtrace+0x1db/0x207 [ 1190.792832][ T23] watchdog+0xa99/0xfd0 [ 1190.797106][ T23] ? reset_hung_task_detector+0x30/0x30 [ 1190.802660][ T23] kthread+0x318/0x420 [ 1190.806720][ T23] ? kthread_create_on_node+0xf0/0xf0 [ 1190.812081][ T23] ret_from_fork+0x24/0x30 [ 1190.816986][ T23] Sending NMI from CPU 0 to CPUs 1: [ 1190.822408][ C1] NMI backtrace for cpu 1 skipped: idling at default_idle+0x28/0x300 [ 1190.823313][ T23] Kernel panic - not syncing: hung_task: blocked tasks [ 1190.837835][ T23] CPU: 0 PID: 23 Comm: khungtaskd Not tainted 5.6.0-rc7-syzkaller #0 [ 1190.845977][ T23] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1190.856753][ T23] Call Trace: [ 1190.860077][ T23] dump_stack+0xef/0x16e [ 1190.864307][ T23] panic+0x2aa/0x6e1 [ 1190.868184][ T23] ? add_taint.cold+0x16/0x16 [ 1190.872869][ T23] ? cpumask_next+0x3c/0x40 [ 1190.877352][ T23] ? printk_safe_flush+0xd9/0x120 [ 1190.882878][ T23] ? watchdog+0xa99/0xfd0 [ 1190.887185][ T23] ? nmi_trigger_cpumask_backtrace+0x1b3/0x207 [ 1190.893347][ T23] watchdog+0xaaa/0xfd0 [ 1190.897489][ T23] ? reset_hung_task_detector+0x30/0x30 [ 1190.903017][ T23] kthread+0x318/0x420 [ 1190.907093][ T23] ? kthread_create_on_node+0xf0/0xf0 [ 1190.912471][ T23] ret_from_fork+0x24/0x30 [ 1190.917814][ T23] Kernel Offset: disabled [ 1190.922169][ T23] Rebooting in 86400 seconds..