[ 45.148881] audit: type=1800 audit(1555047698.554:27): pid=5328 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="restorecond" dev="sda1" ino=2469 res=0 [ 45.168666] audit: type=1800 audit(1555047698.554:28): pid=5328 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. [ 45.872531] audit: type=1800 audit(1555047699.314:29): pid=5328 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="rc.local" dev="sda1" ino=2465 res=0 [ 45.892025] audit: type=1800 audit(1555047699.314:30): pid=5328 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="rmnologin" dev="sda1" ino=2456 res=0 Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.1.31' (ECDSA) to the list of known hosts. 2019/04/12 05:53:35 parsed 1 programs 2019/04/12 05:53:37 executed programs: 0 syzkaller login: [ 763.812461] e cgroup1: Unknown subsys name 'hugetlb' [ 763.827868] IPVS: ftp: loaded support on port[0] = 21 [ 763.900564] bridge0: port 1(bridge_slave_0) entered blocking state [ 763.907302] bridge0: port 1(bridge_slave_0) entered disabled state [ 763.914263] device bridge_slave_0 entered promiscuous mode [ 763.921422] bridge0: port 2(bridge_slave_1) entered blocking state [ 763.927847] bridge0: port 2(bridge_slave_1) entered disabled state [ 763.934640] device bridge_slave_1 entered promiscuous mode [ 763.949319] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 763.958316] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 763.973483] team0: Port device team_slave_0 added [ 763.979387] team0: Port device team_slave_1 added [ 764.002342] bridge0: port 2(bridge_slave_1) entered blocking state [ 764.008796] bridge0: port 2(bridge_slave_1) entered forwarding state [ 764.015581] bridge0: port 1(bridge_slave_0) entered blocking state [ 764.021956] bridge0: port 1(bridge_slave_0) entered forwarding state [ 764.050141] 8021q: adding VLAN 0 to HW filter on device bond0 [ 764.060211] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 764.070308] bridge0: port 1(bridge_slave_0) entered disabled state [ 764.077543] bridge0: port 2(bridge_slave_1) entered disabled state [ 764.084903] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 764.094862] 8021q: adding VLAN 0 to HW filter on device team0 [ 764.103995] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 764.111810] bridge0: port 1(bridge_slave_0) entered blocking state [ 764.118177] bridge0: port 1(bridge_slave_0) entered forwarding state [ 764.127921] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 764.135649] bridge0: port 2(bridge_slave_1) entered blocking state [ 764.142047] bridge0: port 2(bridge_slave_1) entered forwarding state [ 764.157113] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 764.164751] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 764.173985] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 764.184922] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 764.193787] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 764.235056] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 764.556350] usb 1-1: new high-speed USB device number 2 using dummy_hcd [ 764.826263] usb 1-1: Using ep0 maxpacket: 8 [ 764.956378] usb 1-1: config 0 has an invalid interface number: 69 but max is 0 [ 764.963958] usb 1-1: config 0 has no interface number 0 [ 764.969415] usb 1-1: New USB device found, idVendor=17e9, idProduct=1ce0, bcdDevice=99.6a [ 764.977875] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 764.990297] usb 1-1: config 0 descriptor?? [ 765.266410] udlfb 1-1:0.69: vendor descriptor not available (-71) [ 765.286295] usb 1-1: Read EDID byte 0 failed: -71 [ 765.306254] usb 1-1: Read EDID byte 0 failed: -71 [ 765.326270] usb 1-1: Read EDID byte 0 failed: -71 [ 765.331126] usb 1-1: Unable to get valid EDID from device/display [ 765.358287] usb 1-1: submit urb error: -2 [ 765.363832] udlfb: probe of 1-1:0.69 failed with error -2 [ 765.426660] [drm] vendor descriptor length:b9 data:00 00 00 00 00 00 00 00 00 00 00 [ 765.435119] [drm:udl_driver_load.cold] *ERROR* Unrecognized vendor firmware descriptor [ 765.456447] [drm:udl_driver_load] *ERROR* Selecting channel failed [ 765.468519] [drm:udl_submit_urb] *ERROR* usb_submit_urb error fffffffe [ 765.487069] [drm:udl_get_edid_block] *ERROR* Read EDID byte 0 failed err ffffffb9 [ 765.494910] [drm] Cannot find any crtc or sizes [ 765.501196] [drm:udl_submit_urb] *ERROR* usb_submit_urb error fffffffe [ 765.508448] [drm] Initialized udl 0.0.1 20120220 for 1-1:0.69 on minor 1 [ 765.515282] [drm] Initialized udl on minor 1 [ 765.521494] usb 1-1: USB disconnect, device number 2 [ 766.086249] usb 1-1: new high-speed USB device number 3 using dummy_hcd [ 766.326341] usb 1-1: Using ep0 maxpacket: 8 [ 766.446314] usb 1-1: config 0 has an invalid interface number: 69 but max is 0 [ 766.453782] usb 1-1: config 0 has no interface number 0 [ 766.459274] usb 1-1: New USB device found, idVendor=17e9, idProduct=1ce0, bcdDevice=99.6a [ 766.467750] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 766.476377] usb 1-1: config 0 descriptor?? [ 766.697065] usb-fuzzer-gadget dummy_udc.0: failed to start USB fuzzer: -22 [ 766.716247] dummy_hcd dummy_hcd.0: bogus device speed 2019/04/12 05:53:43 executed programs: 2 2019/04/12 05:53:49 executed programs: 4 2019/04/12 05:53:55 executed programs: 6 2019/04/12 05:54:01 executed programs: 8 2019/04/12 05:54:07 executed programs: 10 2019/04/12 05:54:13 executed programs: 12 2019/04/12 05:54:19 executed programs: 14 2019/04/12 05:54:25 executed programs: 16 2019/04/12 05:54:31 executed programs: 18 2019/04/12 05:54:37 executed programs: 20 2019/04/12 05:54:43 executed programs: 22 2019/04/12 05:54:49 executed programs: 24 2019/04/12 05:54:55 executed programs: 26 2019/04/12 05:55:01 executed programs: 28 2019/04/12 05:55:07 executed programs: 30 2019/04/12 05:55:13 executed programs: 32 2019/04/12 05:55:19 executed programs: 34 2019/04/12 05:55:25 executed programs: 36 2019/04/12 05:55:31 executed programs: 38 2019/04/12 05:55:37 executed programs: 40 2019/04/12 05:55:43 executed programs: 42 2019/04/12 05:55:49 executed programs: 44 2019/04/12 05:55:55 executed programs: 46 2019/04/12 05:56:01 executed programs: 48 2019/04/12 05:56:07 executed programs: 50 2019/04/12 05:56:13 executed programs: 52 [ 922.926273] INFO: task kworker/0:1:12 blocked for more than 143 seconds. [ 922.933272] Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 922.938951] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 922.946951] kworker/0:1 D24768 12 2 0x80000000 [ 922.952696] Workqueue: usb_hub_wq hub_event [ 922.957069] Call Trace: [ 922.959713] ? __schedule+0x6f8/0x1d00 [ 922.963620] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 922.968897] ? firmware_map_remove+0x1a1/0x1a1 [ 922.973501] ? wait_woken+0x250/0x250 [ 922.977383] ? put_device+0x21/0x30 [ 922.981023] schedule+0x8f/0x180 [ 922.984488] usb_kill_urb+0x22a/0x2c0 [ 922.988442] ? usb_poison_anchored_urbs+0x160/0x160 [ 922.993469] ? bus_for_each_drv+0x163/0x1e0 [ 922.997844] ? __device_attach+0x223/0x3a0 [ 923.002154] ? finish_wait+0x260/0x260 [ 923.006044] ? usb_submit_urb+0x6f9/0x1480 [ 923.010339] usb_start_wait_urb+0x257/0x4d0 [ 923.014732] ? fault_create_debugfs_attr+0x1e0/0x1e0 [ 923.019910] ? bus_for_each_drv+0x163/0x1e0 [ 923.024238] ? sg_clean+0x240/0x240 [ 923.027984] ? kasan_unpoison_shadow+0x30/0x40 [ 923.032577] ? memset+0x20/0x40 [ 923.036051] usb_control_msg+0x321/0x4a0 [ 923.040151] ? usb_start_wait_urb+0x4d0/0x4d0 [ 923.044684] usb_get_descriptor+0xc6/0x1c0 [ 923.049143] dlfb_usb_probe+0x26f/0x450 [ 923.053146] ? mark_held_locks+0x9f/0xe0 [ 923.057920] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 923.063036] ? lockdep_hardirqs_on+0x37e/0x580 [ 923.067860] ? __pm_runtime_set_status+0x5d6/0xa10 [ 923.072800] ? edid_store+0x190/0x190 [ 923.076700] ? __pm_runtime_resume+0x116/0x180 [ 923.081339] usb_probe_interface+0x31d/0x820 [ 923.085742] ? usb_probe_device+0x150/0x150 [ 923.090109] really_probe+0x2da/0xb10 [ 923.093928] driver_probe_device+0x21d/0x350 [ 923.098374] __device_attach_driver+0x1d8/0x290 [ 923.103052] ? driver_allows_async_probing+0x160/0x160 [ 923.108412] bus_for_each_drv+0x163/0x1e0 [ 923.112563] ? bus_rescan_devices+0x30/0x30 [ 923.116914] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 923.122121] ? lockdep_hardirqs_on+0x37e/0x580 [ 923.126756] __device_attach+0x223/0x3a0 [ 923.130817] ? device_bind_driver+0xe0/0xe0 [ 923.135181] ? kobject_uevent_env+0x295/0x13d0 [ 923.139969] bus_probe_device+0x1f1/0x2a0 [ 923.144173] ? blocking_notifier_call_chain+0x59/0xb0 [ 923.149492] device_add+0xad2/0x16e0 [ 923.153229] ? get_device_parent.isra.0+0x560/0x560 [ 923.158333] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 923.163452] usb_set_configuration+0xdf7/0x1740 [ 923.168197] generic_probe+0xa2/0xda [ 923.172024] usb_probe_device+0xc0/0x150 [ 923.176079] ? usb_suspend+0x5f0/0x5f0 [ 923.180074] really_probe+0x2da/0xb10 [ 923.183886] driver_probe_device+0x21d/0x350 [ 923.188464] __device_attach_driver+0x1d8/0x290 [ 923.193146] ? driver_allows_async_probing+0x160/0x160 [ 923.198464] bus_for_each_drv+0x163/0x1e0 [ 923.202625] ? bus_rescan_devices+0x30/0x30 [ 923.207005] ? _raw_spin_unlock_irqrestore+0x4b/0x60 [ 923.212420] ? lockdep_hardirqs_on+0x37e/0x580 [ 923.217145] __device_attach+0x223/0x3a0 [ 923.221210] ? device_bind_driver+0xe0/0xe0 [ 923.225575] ? kobject_uevent_env+0x295/0x13d0 [ 923.230223] bus_probe_device+0x1f1/0x2a0 [ 923.234369] ? blocking_notifier_call_chain+0x59/0xb0 [ 923.239647] device_add+0xad2/0x16e0 [ 923.243363] ? get_device_parent.isra.0+0x560/0x560 [ 923.248543] usb_new_device.cold+0x537/0xccf [ 923.253056] hub_event+0x138e/0x3b00 [ 923.256838] ? hub_port_debounce+0x350/0x350 [ 923.261250] ? _raw_spin_unlock_irq+0x29/0x40 [ 923.265790] process_one_work+0x90f/0x1580 [ 923.270215] ? wq_pool_ids_show+0x300/0x300 [ 923.274535] ? do_raw_spin_lock+0x11f/0x290 [ 923.278925] worker_thread+0x7b0/0xe20 [ 923.282860] ? process_one_work+0x1580/0x1580 [ 923.287403] kthread+0x313/0x420 [ 923.290866] ? kthread_park+0x1a0/0x1a0 [ 923.294953] ret_from_fork+0x3a/0x50 [ 923.299391] [ 923.299391] Showing all locks held in the system: [ 923.305811] 5 locks held by kworker/0:1/12: [ 923.310206] #0: 00000000166cd93b ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x81f/0x1580 [ 923.319744] #1: 000000004f56bfe4 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x853/0x1580 [ 923.331179] #2: 0000000083c5e00c (&dev->mutex){....}, at: hub_event+0x18a/0x3b00 [ 923.338925] #3: 00000000d81e0bcb (&dev->mutex){....}, at: __device_attach+0x80/0x3a0 [ 923.347058] #4: 00000000cadabca0 (&dev->mutex){....}, at: __device_attach+0x80/0x3a0 [ 923.355633] 1 lock held by khungtaskd/23: [ 923.359820] #0: 000000005a371517 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x269 [ 923.368494] 1 lock held by rsyslogd/5367: [ 923.372627] #0: 0000000092171888 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xe8/0x100 [ 923.380629] 2 locks held by getty/5457: [ 923.384587] #0: 00000000eb943119 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.393189] #1: 0000000029f01f8d (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.402075] 2 locks held by getty/5458: [ 923.406041] #0: 00000000eef72ed7 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.414758] #1: 00000000f0b7a7af (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.423654] 2 locks held by getty/5459: [ 923.427669] #0: 000000006f138c4b (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.436223] #1: 000000007ecd4272 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.445072] 2 locks held by getty/5460: [ 923.449110] #0: 00000000122328ea (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.457646] #1: 0000000086acf3a5 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.466934] 2 locks held by getty/5461: [ 923.470893] #0: 000000000f9f52d4 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.479644] #1: 0000000018d41ec8 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.488782] 2 locks held by getty/5462: [ 923.492808] #0: 00000000e72041b7 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.501395] #1: 00000000074e6467 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.510569] 2 locks held by getty/5463: [ 923.514530] #0: 0000000015fa0e73 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x27/0x80 [ 923.523193] #1: 00000000810c4643 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21c/0x1a60 [ 923.532107] [ 923.533724] ============================================= [ 923.533724] [ 923.540814] NMI backtrace for cpu 1 [ 923.544445] CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 923.552439] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 923.562042] Call Trace: [ 923.564677] dump_stack+0xe8/0x16e [ 923.568233] ? x86_vector_activate.cold+0x3b/0x92 [ 923.573078] nmi_cpu_backtrace.cold+0x48/0x87 [ 923.577615] ? lapic_can_unplug_cpu.cold+0x41/0x41 [ 923.582547] nmi_trigger_cpumask_backtrace+0x1a6/0x1bd [ 923.588003] watchdog+0x98e/0xe20 [ 923.591778] ? reset_hung_task_detector+0x30/0x30 [ 923.596620] kthread+0x313/0x420 [ 923.599983] ? kthread_park+0x1a0/0x1a0 [ 923.604052] ret_from_fork+0x3a/0x50 [ 923.607881] Sending NMI from CPU 1 to CPUs 0: [ 923.612499] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10 [ 923.613431] Kernel panic - not syncing: hung_task: blocked tasks [ 923.626215] CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.1.0-rc4-319354-g9a33b36 #3 [ 923.634394] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 923.643738] Call Trace: [ 923.646325] dump_stack+0xe8/0x16e [ 923.650162] panic+0x29d/0x5f2 [ 923.653348] ? __warn_printk+0xf8/0xf8 [ 923.657232] ? cpumask_next+0x1f/0x30 [ 923.661063] ? printk_safe_flush+0xde/0x130 [ 923.665374] ? watchdog+0x98e/0xe20 [ 923.669154] ? printk_safe_flush+0xde/0x130 [ 923.673471] watchdog+0x99f/0xe20 [ 923.677082] ? reset_hung_task_detector+0x30/0x30 [ 923.681910] kthread+0x313/0x420 [ 923.685386] ? kthread_park+0x1a0/0x1a0 [ 923.689559] ret_from_fork+0x3a/0x50 [ 923.695054] Kernel Offset: disabled [ 923.698885] Rebooting in 86400 seconds..