INIT: Entering runlevel: 2 [info] Using makefile-style concurrent boot in runlevel 2. [....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [....] 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 'ci-upstream-mmots-kasan-gce-5,10.128.15.230' (ECDSA) to the list of known hosts. executing program syzkaller login: [ 492.511154] INFO: task blkid:3090 blocked for more than 120 seconds. [ 492.512202] Not tainted 4.15.0-rc1-mm1+ #29 [ 492.512846] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.514135] blkid D23696 3090 3062 0x00000004 [ 492.514907] Call Trace: [ 492.515310] __schedule+0x8eb/0x2060 [ 492.515839] ? print_usage_bug+0x3f0/0x3f0 [ 492.516448] ? __sched_text_start+0x8/0x8 [ 492.517045] ? print_usage_bug+0x3f0/0x3f0 [ 492.517624] ? find_held_lock+0x39/0x1d0 [ 492.518211] schedule+0xf5/0x430 [ 492.518668] ? __mutex_lock+0x703/0x1a80 [ 492.519241] ? __schedule+0x2060/0x2060 [ 492.519779] ? lock_release+0xda0/0xda0 [ 492.520403] ? memset+0x31/0x40 [ 492.520863] ? do_raw_spin_trylock+0x190/0x190 [ 492.521503] ? debug_mutex_free_waiter+0x1b0/0x1b0 [ 492.522179] ? mutex_destroy+0x1d0/0x1d0 [ 492.522735] schedule_preempt_disabled+0x10/0x20 [ 492.523395] __mutex_lock+0xaad/0x1a80 [ 492.523924] ? __blkdev_get+0x158/0x10e0 [ 492.524506] ? mutex_lock_io_nested+0x1900/0x1900 [ 492.525173] ? check_noncircular+0x20/0x20 [ 492.525740] ? print_usage_bug+0x3f0/0x3f0 [ 492.526340] ? find_held_lock+0x39/0x1d0 [ 492.526891] ? __lock_acquire+0x6e9/0x47f0 [ 492.527502] ? get_disk+0xd0/0xd0 [ 492.527976] ? __mutex_unlock_slowpath+0xe9/0xac0 [ 492.528660] ? wait_for_completion+0x7b0/0x7b0 [ 492.529298] ? lock_downgrade+0x980/0x980 [ 492.529871] ? free_modinfo_version+0x70/0x70 [ 492.530514] ? refcount_add+0x60/0x60 [ 492.531058] ? match_exception+0x360/0x360 [ 492.532777] ? kobject_get_unless_zero+0x29/0x40 [ 492.537553] ? get_disk+0xd0/0xd0 [ 492.541040] ? kobj_lookup+0x2c6/0x410 [ 492.544948] mutex_lock_nested+0x16/0x20 [ 492.549037] ? mutex_lock_nested+0x16/0x20 [ 492.553275] __blkdev_get+0x158/0x10e0 [ 492.557202] ? __blkdev_put+0x7c0/0x7c0 [ 492.561190] ? lock_downgrade+0x980/0x980 [ 492.565363] blkdev_get+0x3a1/0xad0 [ 492.569039] ? bd_link_disk_holder+0x8b0/0x8b0 [ 492.573636] ? do_raw_spin_trylock+0x190/0x190 [ 492.578242] ? errseq_sample+0xee/0x140 [ 492.582215] ? _copy_to_user+0xc0/0xc0 [ 492.586114] ? _raw_spin_unlock+0x22/0x30 [ 492.590307] blkdev_open+0x1e4/0x270 [ 492.594047] ? security_file_open+0x89/0x1a0 [ 492.598476] do_dentry_open+0x682/0xd70 [ 492.602473] ? bd_acquire+0x2c0/0x2c0 [ 492.606302] vfs_open+0x107/0x230 [ 492.609774] path_openat+0x1157/0x3530 [ 492.613700] ? path_lookupat+0xba0/0xba0 [ 492.617777] ? getname+0x19/0x20 [ 492.621166] ? do_sys_open+0x2e7/0x6d0 [ 492.625072] ? do_raw_spin_trylock+0x190/0x190 [ 492.629676] ? __lock_is_held+0xbc/0x140 [ 492.633765] ? _raw_spin_unlock+0x22/0x30 [ 492.637935] ? __alloc_fd+0x29b/0x750 [ 492.641757] do_filp_open+0x25b/0x3b0 [ 492.645582] ? may_open_dev+0xe0/0xe0 [ 492.649407] ? mpi_resize+0x200/0x200 [ 492.653233] ? get_unused_fd_flags+0x121/0x190 [ 492.657829] ? getname_flags+0x256/0x580 [ 492.661904] do_sys_open+0x502/0x6d0 [ 492.665614] ? do_sys_open+0x502/0x6d0 [ 492.669514] ? filp_open+0x70/0x70 [ 492.673052] ? entry_SYSCALL_64_fastpath+0x5/0x96 [ 492.677912] ? trace_hardirqs_on_caller+0x421/0x5c0 [ 492.682937] SyS_open+0x2d/0x40 [ 492.686235] entry_SYSCALL_64_fastpath+0x1f/0x96 [ 492.690984] RIP: 0033:0x7fe5c5bfc120 [ 492.694714] RSP: 002b:00007ffde0d34f08 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 [ 492.702432] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe5c5bfc120 [ 492.709719] RDX: 00007ffde0d35f34 RSI: 0000000000000000 RDI: 00007ffde0d35f34 [ 492.717005] RBP: 0000000000000000 R08: 0000000000000078 R09: 0000000000000000 [ 492.724313] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000211e030 [ 492.731608] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000005 [ 492.738905] [ 492.738905] Showing all locks held in the system: [ 492.745258] 2 locks held by khungtaskd/675: [ 492.749596] #0: (rcu_read_lock){....}, at: [<000000007fb79bbe>] watchdog+0x1c5/0xd60 [ 492.757698] #1: (tasklist_lock){.+.+}, at: [<0000000035358c26>] debug_show_all_locks+0xd3/0x400 [ 492.766756] 1 lock held by rsyslogd/2973: [ 492.770922] #0: (&f->f_pos_lock){+.+.}, at: [<0000000001261d81>] __fdget_pos+0x131/0x1a0 [ 492.779371] 2 locks held by getty/3055: [ 492.783357] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.792050] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.801358] 2 locks held by getty/3056: [ 492.805329] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.814030] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.823313] 2 locks held by getty/3057: [ 492.827287] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.835954] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.845256] 2 locks held by getty/3058: [ 492.849219] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.857924] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.867229] 2 locks held by getty/3059: [ 492.871212] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.879911] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.889211] 2 locks held by getty/3060: [ 492.893192] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.901901] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.911210] 2 locks held by getty/3061: [ 492.915192] #0: (&tty->ldisc_sem){++++}, at: [<000000005cc11435>] ldsem_down_read+0x37/0x40 [ 492.923879] #1: (&ldata->atomic_read_lock){+.+.}, at: [<0000000008d2b0f7>] n_tty_read+0x2f2/0x1a10 [ 492.933187] 1 lock held by syzkaller346228/3087: [ 492.937945] #0: (&bdev->bd_mutex){+.+.}, at: [<0000000099fa8891>] __blkdev_put+0xa7/0x7c0 [ 492.946479] 1 lock held by blkid/3090: [ 492.950357] #0: (&bdev->bd_mutex){+.+.}, at: [<00000000d4caea9e>] __blkdev_get+0x158/0x10e0 [ 492.959054] [ 492.960678] ============================================= [ 492.960678] [ 492.967713] NMI backtrace for cpu 0 [ 492.971348] CPU: 0 PID: 675 Comm: khungtaskd Not tainted 4.15.0-rc1-mm1+ #29 [ 492.978508] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 492.987830] Call Trace: [ 492.990389] dump_stack+0x194/0x257 [ 492.993984] ? arch_local_irq_restore+0x53/0x53 [ 492.998620] ? debug_show_all_locks+0x2f4/0x400 [ 493.003259] ? nmi_cpu_backtrace+0x1be/0x210 [ 493.007639] ? lapic_can_unplug_cpu+0xa0/0xa0 [ 493.012100] nmi_cpu_backtrace+0x1d2/0x210 [ 493.016302] ? lapic_can_unplug_cpu+0xa0/0xa0 [ 493.020761] nmi_trigger_cpumask_backtrace+0x122/0x180 [ 493.026007] arch_trigger_cpumask_backtrace+0x14/0x20 [ 493.031165] watchdog+0x90c/0xd60 [ 493.034595] ? reset_hung_task_detector+0xa0/0xa0 [ 493.039405] ? default_wake_function+0x30/0x50 [ 493.043963] ? __schedule+0x2060/0x2060 [ 493.047902] ? do_wait_intr+0x3e0/0x3e0 [ 493.051847] ? do_raw_spin_trylock+0x190/0x190 [ 493.056396] ? _raw_spin_unlock_irqrestore+0x31/0xba [ 493.061465] ? trace_hardirqs_on_caller+0x421/0x5c0 [ 493.066448] ? trace_hardirqs_on+0xd/0x10 [ 493.070562] ? __kthread_parkme+0x175/0x240 [ 493.074852] kthread+0x37a/0x440 [ 493.078184] ? reset_hung_task_detector+0xa0/0xa0 [ 493.082988] ? kthread_stop+0x7b0/0x7b0 [ 493.086931] ret_from_fork+0x24/0x30 [ 493.090720] Sending NMI from CPU 0 to CPUs 1: [ 493.095240] NMI backtrace for cpu 1 [ 493.095247] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.15.0-rc1-mm1+ #29 [ 493.095249] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 493.095252] task: 0000000064c7084b task.stack: 00000000bb7e08d1 [ 493.095259] RIP: 0010:sched_ttwu_pending+0x0/0x270 [ 493.095261] RSP: 0018:ffff8801db507d68 EFLAGS: 00000046 [ 493.095264] RAX: 0000000000000003 RBX: 0000000000027900 RCX: 0000000000000001 [ 493.095266] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff8801da3894a0 [ 493.095269] RBP: ffff8801db507e90 R08: 0000000000000001 R09: ffff88021fff8048 [ 493.095271] R10: ffff88021fff8050 R11: ffff88021fff805d R12: ffff8801da388300 [ 493.095273] R13: 1ffff1003b6a0fb1 R14: ffff8801db507e68 R15: 0000000000000001 [ 493.095276] FS: 0000000000000000(0000) GS:ffff8801db500000(0000) knlGS:0000000000000000 [ 493.095278] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 493.095280] CR2: 00007fe5c5bfc110 CR3: 00000001d1b96000 CR4: 00000000001406e0 [ 493.095284] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 493.095286] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 493.095287] Call Trace: [ 493.095289] [ 493.095294] ? scheduler_ipi+0x24b/0x830 [ 493.095300] ? migration_cpu_stop+0x470/0x470 [ 493.095308] ? tick_program_event+0x83/0x100 [ 493.095312] ? task_prio+0x40/0x40 [ 493.095321] smp_reschedule_interrupt+0xe6/0x670 [ 493.095325] ? smp_thermal_interrupt+0x700/0x700 [ 493.095332] ? _raw_spin_lock+0x32/0x40 [ 493.095336] ? _raw_spin_unlock+0x22/0x30 [ 493.095341] ? handle_edge_irq+0x2b4/0x7c0 [ 493.095345] ? task_prio+0x40/0x40 [ 493.095353] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 493.095358] reschedule_interrupt+0xa9/0xb0 [ 493.095359] [ 493.095362] RIP: 0010:native_safe_halt+0x6/0x10 [ 493.095364] RSP: 0018:ffff8801da397da8 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff02 [ 493.095367] RAX: dffffc0000000000 RBX: 1ffff1003b472fb8 RCX: 0000000000000000 [ 493.095369] RDX: 1ffffffff0bd9744 RSI: 0000000000000001 RDI: ffffffff85ecba20 [ 493.095371] RBP: ffff8801da397da8 R08: 0000000000000000 R09: 0000000000000000 [ 493.095373] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001 [ 493.095374] R13: ffff8801da397e60 R14: ffffffff865eca20 R15: 0000000000000000 [ 493.095382] ? trace_hardirqs_on+0xd/0x10 [ 493.095385] default_idle+0xbf/0x430 [ 493.095389] ? __sched_text_end+0x4/0x4 [ 493.095395] ? rcu_eqs_special_set+0x1e0/0x1e0 [ 493.095399] ? tsc_verify_tsc_adjust+0xf6/0x3e0 [ 493.095402] ? set_cpu_sd_state_idle+0x1dc/0x2d0 [ 493.095406] ? mark_tsc_async_resets+0x30/0x30 [ 493.095414] arch_cpu_idle+0xa/0x10 [ 493.095417] default_idle_call+0x36/0x90 [ 493.095421] do_idle+0x24a/0x3b0 [ 493.095424] ? complete+0x6a/0x80 [ 493.095429] cpu_startup_entry+0x18/0x20 [ 493.095432] start_secondary+0x2dd/0x3e0 [ 493.095436] secondary_startup_64+0xa5/0xb0 [ 493.095441] Code: ff ff 4c 89 85 70 ff ff ff e8 ad 12 5a 00 48 8b 95 68 ff ff ff 4c 8b 85 70 ff ff ff e9 19 fe ff ff 66 2e 0f 1f 84 00 00 00 00 00 <55> 48 89 e5 41 57 41 56 41 55 4c 8d ad 78 ff ff ff 49 be 00 00 [ 493.096241] Kernel panic - not syncing: hung_task: blocked tasks [ 493.096247] CPU: 0 PID: 675 Comm: khungtaskd Not tainted 4.15.0-rc1-mm1+ #29 [ 493.096249] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 493.096251] Call Trace: [ 493.096259] dump_stack+0x194/0x257 [ 493.096267] ? arch_local_irq_restore+0x53/0x53 [ 493.096276] ? vsnprintf+0x1ed/0x1900 [ 493.096287] panic+0x1e4/0x41c [ 493.096292] ? refcount_error_report+0x214/0x214 [ 493.096305] ? nmi_trigger_cpumask_backtrace+0xef/0x180 [ 493.096315] watchdog+0x91d/0xd60 [ 493.096330] ? reset_hung_task_detector+0xa0/0xa0 [ 493.096336] ? default_wake_function+0x30/0x50 [ 493.096349] ? __schedule+0x2060/0x2060 [ 493.096354] ? do_wait_intr+0x3e0/0x3e0 [ 493.096362] ? do_raw_spin_trylock+0x190/0x190 [ 493.096369] ? _raw_spin_unlock_irqrestore+0x31/0xba [ 493.096376] ? trace_hardirqs_on_caller+0x421/0x5c0 [ 493.096382] ? trace_hardirqs_on+0xd/0x10 [ 493.096386] ? __kthread_parkme+0x175/0x240 [ 493.096395] kthread+0x37a/0x440 [ 493.096400] ? reset_hung_task_detector+0xa0/0xa0 [ 493.096403] ? kthread_stop+0x7b0/0x7b0 [ 493.096410] ret_from_fork+0x24/0x30 [ 493.495141] Dumping ftrace buffer: [ 493.498853] (ftrace buffer empty) [ 493.502563] Kernel Offset: disabled [ 493.506177] Rebooting in 86400 seconds..