[ 47.931423] audit: type=1800 audit(1555086122.312:25): pid=5653 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="cron" dev="sda1" ino=2447 res=0 [ 47.950599] audit: type=1800 audit(1555086122.312:26): pid=5653 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2490 res=0 [ 47.970105] audit: type=1800 audit(1555086122.312:27): pid=5653 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="restorecond" dev="sda1" ino=2469 res=0 [ 47.989610] audit: type=1800 audit(1555086122.312:28): pid=5653 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="ssh" dev="sda1" ino=2450 res=0 [....] Starting periodic command scheduler: cron[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[ ok 8[?25h[?0c. Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.0.103' (ECDSA) to the list of known hosts. 2019/04/12 16:34:14 parsed 1 programs 2019/04/12 16:34:15 executed programs: 0 syzkaller login: [ 781.531682] e cgroup1: Unknown subsys name 'hugetlb' [ 781.549229] IPVS: ftp: loaded support on port[0] = 21 [ 781.629791] bridge0: port 1(bridge_slave_0) entered blocking state [ 781.636468] bridge0: port 1(bridge_slave_0) entered disabled state [ 781.643834] device bridge_slave_0 entered promiscuous mode [ 781.651084] bridge0: port 2(bridge_slave_1) entered blocking state [ 781.657411] bridge0: port 2(bridge_slave_1) entered disabled state [ 781.664528] device bridge_slave_1 entered promiscuous mode [ 781.678852] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 781.687491] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 781.703353] team0: Port device team_slave_0 added [ 781.709309] team0: Port device team_slave_1 added [ 781.732431] bridge0: port 2(bridge_slave_1) entered blocking state [ 781.739085] bridge0: port 2(bridge_slave_1) entered forwarding state [ 781.745928] bridge0: port 1(bridge_slave_0) entered blocking state [ 781.752456] bridge0: port 1(bridge_slave_0) entered forwarding state [ 781.781032] 8021q: adding VLAN 0 to HW filter on device bond0 [ 781.792663] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 781.802022] bridge0: port 1(bridge_slave_0) entered disabled state [ 781.809953] bridge0: port 2(bridge_slave_1) entered disabled state [ 781.817227] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 781.827825] 8021q: adding VLAN 0 to HW filter on device team0 [ 781.836777] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 781.844595] bridge0: port 1(bridge_slave_0) entered blocking state [ 781.850967] bridge0: port 1(bridge_slave_0) entered forwarding state [ 781.868884] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 781.876665] bridge0: port 2(bridge_slave_1) entered blocking state [ 781.883050] bridge0: port 2(bridge_slave_1) entered forwarding state [ 781.890483] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 781.898699] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 781.906888] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 781.915613] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 781.926488] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 781.977063] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 782.327664] usb 1-1: new high-speed USB device number 2 using dummy_hcd [ 782.567643] usb 1-1: Using ep0 maxpacket: 8 [ 782.687668] usb 1-1: config 0 has an invalid interface number: 137 but max is 0 [ 782.695414] usb 1-1: config 0 has no interface number 0 [ 782.701184] usb 1-1: New USB device found, idVendor=0565, idProduct=0003, bcdDevice=2e.70 [ 782.709851] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 782.721067] usb 1-1: config 0 descriptor?? [ 782.967723] kaweth 1-1:0.137: Firmware present in device. [ 782.988003] kaweth 1-1:0.137: Error reading configuration (-71), no net device created [ 782.996596] kaweth: probe of 1-1:0.137 failed with error -5 [ 783.005905] usb 1-1: USB disconnect, device number 2 [ 783.707912] usb 1-1: new high-speed USB device number 3 using dummy_hcd [ 783.948306] usb 1-1: Using ep0 maxpacket: 8 [ 784.077742] usb 1-1: config 0 has an invalid interface number: 137 but max is 0 [ 784.085292] usb 1-1: config 0 has no interface number 0 [ 784.090837] usb 1-1: New USB device found, idVendor=0565, idProduct=0003, bcdDevice=2e.70 [ 784.099692] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 784.108965] usb 1-1: config 0 descriptor?? [ 784.328507] usb-fuzzer-gadget dummy_udc.0: failed to start USB fuzzer: -22 [ 784.337616] dummy_hcd dummy_hcd.0: bogus device speed 2019/04/12 16:34:21 executed programs: 2 2019/04/12 16:34:27 executed programs: 4 2019/04/12 16:34:33 executed programs: 6 2019/04/12 16:34:39 executed programs: 8 2019/04/12 16:34:45 executed programs: 10 2019/04/12 16:34:51 executed programs: 12 2019/04/12 16:34:57 executed programs: 14 2019/04/12 16:35:03 executed programs: 16 2019/04/12 16:35:09 executed programs: 18 2019/04/12 16:35:15 executed programs: 20 2019/04/12 16:35:21 executed programs: 22 2019/04/12 16:35:28 executed programs: 24 2019/04/12 16:35:34 executed programs: 26 2019/04/12 16:35:40 executed programs: 28 2019/04/12 16:35:46 executed programs: 30 2019/04/12 16:35:52 executed programs: 32 2019/04/12 16:35:58 executed programs: 34 2019/04/12 16:36:04 executed programs: 36 2019/04/12 16:36:10 executed programs: 38 2019/04/12 16:36:16 executed programs: 40 2019/04/12 16:36:22 executed programs: 42 2019/04/12 16:36:28 executed programs: 44 2019/04/12 16:36:34 executed programs: 46 2019/04/12 16:36:40 executed programs: 48 2019/04/12 16:36:46 executed programs: 50 2019/04/12 16:36:52 executed programs: 52 2019/04/12 16:36:58 executed programs: 54 [ 945.557609] INFO: task kworker/0:0:5832 blocked for more than 143 seconds. [ 945.564791] Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 945.570477] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 945.578484] kworker/0:0 D25632 5832 2 0x80000000 [ 945.584193] Workqueue: usb_hub_wq hub_event [ 945.588561] Call Trace: [ 945.591211] ? __schedule+0x6f8/0x1d00 [ 945.595129] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 945.600289] ? firmware_map_remove+0x1a1/0x1a1 [ 945.604914] ? wait_woken+0x250/0x250 [ 945.608865] ? put_device+0x21/0x30 [ 945.612632] schedule+0x8f/0x180 [ 945.616112] usb_kill_urb+0x22a/0x2c0 [ 945.619963] ? usb_poison_anchored_urbs+0x160/0x160 [ 945.624989] ? bus_for_each_drv+0x163/0x1e0 [ 945.629343] ? __device_attach+0x223/0x3a0 [ 945.633808] ? finish_wait+0x260/0x260 [ 945.637772] ? usb_submit_urb+0x6f9/0x1480 [ 945.642016] usb_start_wait_urb+0x257/0x4d0 [ 945.646390] ? fault_create_debugfs_attr+0x1e0/0x1e0 [ 945.651530] ? sg_clean+0x240/0x240 [ 945.655455] ? kasan_unpoison_shadow+0x30/0x40 [ 945.660084] ? memset+0x20/0x40 [ 945.663382] usb_control_msg+0x321/0x4a0 [ 945.667481] ? usb_start_wait_urb+0x4d0/0x4d0 [ 945.671979] ? kasan_unpoison_shadow+0x30/0x40 [ 945.676656] usb_reset_configuration+0x34f/0x8b0 [ 945.681601] kaweth_probe+0x1f3/0x560 [ 945.685524] ? wait_for_completion+0x3c0/0x3c0 [ 945.690166] ? kaweth_control.constprop.0+0x4f0/0x4f0 [ 945.695533] usb_probe_interface+0x31d/0x820 [ 945.700016] ? usb_probe_device+0x150/0x150 [ 945.704347] really_probe+0x2da/0xb10 [ 945.708699] driver_probe_device+0x21d/0x350 [ 945.713115] __device_attach_driver+0x1d8/0x290 [ 945.718106] ? driver_allows_async_probing+0x160/0x160 [ 945.723388] bus_for_each_drv+0x163/0x1e0 [ 945.727574] ? bus_rescan_devices+0x30/0x30 [ 945.731955] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 945.737448] ? lockdep_hardirqs_on+0x37e/0x580 [ 945.742119] __device_attach+0x223/0x3a0 [ 945.746175] ? device_bind_driver+0xe0/0xe0 [ 945.750855] ? kobject_uevent_env+0x295/0x13d0 [ 945.755469] bus_probe_device+0x1f1/0x2a0 [ 945.759765] ? blocking_notifier_call_chain+0x59/0xb0 [ 945.765017] device_add+0xad2/0x16e0 [ 945.768772] ? get_device_parent.isra.0+0x560/0x560 [ 945.773895] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 945.779070] usb_set_configuration+0xdf7/0x1740 [ 945.783903] generic_probe+0xa2/0xda [ 945.787659] usb_probe_device+0xc0/0x150 [ 945.791735] ? usb_suspend+0x5f0/0x5f0 [ 945.795621] really_probe+0x2da/0xb10 [ 945.799649] driver_probe_device+0x21d/0x350 [ 945.804127] __device_attach_driver+0x1d8/0x290 [ 945.808848] ? driver_allows_async_probing+0x160/0x160 [ 945.814178] bus_for_each_drv+0x163/0x1e0 [ 945.818476] ? bus_rescan_devices+0x30/0x30 [ 945.822810] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 945.828043] ? lockdep_hardirqs_on+0x37e/0x580 [ 945.832636] __device_attach+0x223/0x3a0 [ 945.836688] ? device_bind_driver+0xe0/0xe0 [ 945.841070] ? kobject_uevent_env+0x295/0x13d0 [ 945.845805] bus_probe_device+0x1f1/0x2a0 [ 945.849995] ? blocking_notifier_call_chain+0x59/0xb0 [ 945.855198] device_add+0xad2/0x16e0 [ 945.859039] ? get_device_parent.isra.0+0x560/0x560 [ 945.864086] usb_new_device.cold+0x537/0xccf [ 945.868581] hub_event+0x138e/0x3b00 [ 945.872319] ? hub_port_debounce+0x350/0x350 [ 945.876775] ? _raw_spin_unlock_irq+0x29/0x40 [ 945.881606] process_one_work+0x90f/0x1580 [ 945.885859] ? wq_pool_ids_show+0x300/0x300 [ 945.890264] ? do_raw_spin_lock+0x11f/0x290 [ 945.894614] worker_thread+0x9b/0xe20 [ 945.898481] ? process_one_work+0x1580/0x1580 [ 945.903105] kthread+0x313/0x420 [ 945.906532] ? kthread_park+0x1a0/0x1a0 [ 945.910633] ret_from_fork+0x3a/0x50 [ 945.914423] [ 945.914423] Showing all locks held in the system: [ 945.920866] 1 lock held by khungtaskd/23: [ 945.925147] #0: 00000000b8130602 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x269 [ 945.934333] 2 locks held by rsyslogd/5691: [ 945.938620] #0: 000000007114b623 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xe8/0x100 [ 945.946971] #1: 00000000c06ee739 (&rq->lock){-.-.}, at: __schedule+0x1ed/0x1d00 [ 945.954679] 2 locks held by getty/5782: [ 945.958706] #0: 0000000057cba0a6 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 945.967537] #1: 000000006e82cfff (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 945.976426] 2 locks held by getty/5783: [ 945.980464] #0: 0000000081b2785c (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 945.989050] #1: 00000000d6b93290 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 945.997953] 2 locks held by getty/5784: [ 946.002041] #0: 00000000383aa56a (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 946.010607] #1: 00000000ee1df7fb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 946.019538] 2 locks held by getty/5785: [ 946.023507] #0: 00000000a6483f31 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 946.032292] #1: 000000001194bac3 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 946.041208] 2 locks held by getty/5786: [ 946.045236] #0: 00000000539a7b9e (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 946.053973] #1: 00000000b46ccdc7 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 946.062938] 2 locks held by getty/5787: [ 946.066896] #0: 000000004a2bebaf (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 946.075448] #1: 000000007010051a (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 946.084533] 2 locks held by getty/5788: [ 946.088551] #0: 00000000faaefbc3 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 946.097382] #1: 00000000b324f4a3 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 946.106426] 6 locks held by kworker/0:0/5832: [ 946.110970] #0: 00000000f9dff081 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x81f/0x1580 [ 946.120537] #1: 000000001ac5f11c ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x853/0x1580 [ 946.130593] #2: 00000000c885f477 (&dev->mutex){....}, at: hub_event+0x18a/0x3b00 [ 946.138446] #3: 00000000407283f8 (&dev->mutex){....}, at: __device_attach+0x80/0x3a0 [ 946.146544] #4: 00000000300cb0dc (&dev->mutex){....}, at: __device_attach+0x80/0x3a0 [ 946.154681] #5: 000000006bc63191 (hcd->bandwidth_mutex){+.+.}, at: usb_reset_configuration+0x12c/0x8b0 [ 946.164305] [ 946.165926] ============================================= [ 946.165926] [ 946.172994] NMI backtrace for cpu 1 [ 946.176625] CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 946.184500] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 946.194103] Call Trace: [ 946.196736] dump_stack+0xe8/0x16e [ 946.200443] ? x86_vector_activate.cold+0x3b/0x92 [ 946.205378] nmi_cpu_backtrace.cold+0x48/0x87 [ 946.209865] ? lapic_can_unplug_cpu.cold+0x41/0x41 [ 946.214789] nmi_trigger_cpumask_backtrace+0x1a6/0x1bd [ 946.220249] watchdog+0x98e/0xe20 [ 946.223772] ? reset_hung_task_detector+0x30/0x30 [ 946.228634] kthread+0x313/0x420 [ 946.232017] ? kthread_park+0x1a0/0x1a0 [ 946.236178] ret_from_fork+0x3a/0x50 [ 946.239998] Sending NMI from CPU 1 to CPUs 0: [ 946.244581] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10 [ 946.245514] Kernel panic - not syncing: hung_task: blocked tasks [ 946.258295] CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 946.266170] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 946.275739] Call Trace: [ 946.278360] dump_stack+0xe8/0x16e [ 946.282071] panic+0x29d/0x5f2 [ 946.285267] ? __warn_printk+0xf8/0xf8 [ 946.289168] ? cpumask_next+0x1f/0x30 [ 946.293017] ? printk_safe_flush+0xde/0x130 [ 946.297336] ? watchdog+0x98e/0xe20 [ 946.300963] ? printk_safe_flush+0xde/0x130 [ 946.305288] watchdog+0x99f/0xe20 [ 946.308800] ? reset_hung_task_detector+0x30/0x30 [ 946.313683] kthread+0x313/0x420 [ 946.317042] ? kthread_park+0x1a0/0x1a0 [ 946.321007] ret_from_fork+0x3a/0x50 [ 946.325796] Kernel Offset: disabled [ 946.329487] Rebooting in 86400 seconds..