[....] Starting enhanced syslogd: rsyslogd[ 11.992810] audit: type=1400 audit(1546459777.301:4): avc: denied { syslog } for pid=1905 comm="rsyslogd" capability=34 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [?25l[?1c7[1G[[32m ok [39;49m8[?25h[?0c. Starting mcstransd: [....] Starting periodic command scheduler: cron[?25l[?1c7[1G[[32m ok [39;49m8[?25h[?0c. [....] Starting file context maintaining daemon: restorecond[?25l[?1c7[1G[[32m ok [39;49m8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[1G[[32m ok [39;49m8[?25h[?0c. Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.0.106' (ECDSA) to the list of known hosts. executing program executing program syzkaller login: [ 59.640068] syz-executor269 (2081) used greatest stack depth: 23248 bytes left executing program executing program executing program executing program [ 61.590339] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:620 [ 61.599102] in_atomic(): 1, irqs_disabled(): 0, pid: 0, name: swapper/1 [ 61.605829] no locks held by swapper/1/0. [ 61.610090] Preemption disabled at:[] cpu_startup_entry+0x755/0x810 [ 61.618318] [ 61.619938] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.4.169+ #1 [ 61.626537] 0000000000000000 a6abd3547db406d7 ffff8801db707870 ffffffff81aab9c1 [ 61.634793] ffff8801da6897c0 0000000000000101 ffff8801da6897c0 0000000000000101 [ 61.642770] ffff8801da6897c0 ffff8801db7078a8 ffffffff813a6d4d ffff8801da6897c0 [ 61.651042] Call Trace: [ 61.653597] [] dump_stack+0xc1/0x120 [ 61.659837] [] ___might_sleep.cold+0x1c6/0x1dc [ 61.666131] [] __might_sleep+0x90/0x1a0 [ 61.671728] [] ? blk_done_softirq+0x258/0x3a0 [ 61.677970] [] mutex_lock_nested+0x8d/0xb80 [ 61.684059] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 61.691044] [] ? replace_page_cache_page+0x420/0x420 [ 61.697896] [] ? mutex_trylock+0x500/0x500 [ 61.703876] [] ? filemap_check_errors+0x9d/0xe0 [ 61.710458] [] ? filemap_fdatawait_range+0x3d/0x50 [ 61.717009] [] __generic_file_fsync+0xcf/0x1c0 [ 61.723466] [] generic_file_fsync+0x78/0x120 [ 61.729695] [] ext4_sync_file+0x772/0xf10 [ 61.735471] [] ? mempool_kfree+0x20/0x20 [ 61.741154] [] ? ext4_llseek+0x970/0x970 [ 61.746852] [] vfs_fsync_range+0x111/0x260 [ 61.752712] [] dio_complete+0x3e6/0x720 [ 61.758609] [] dio_bio_end_aio+0x176/0x3f0 [ 61.764832] [] ? dio_complete+0x720/0x720 [ 61.770606] [] bio_endio+0x187/0x1e0 [ 61.776199] [] blk_update_request+0x267/0xa50 [ 61.782324] [] scsi_end_request+0x9c/0x5d0 [ 61.788187] [] scsi_io_completion+0x275/0x1810 [ 61.794389] [] ? trace_hardirqs_on+0x10/0x10 [ 61.800788] [] ? scsi_unblock_requests+0x50/0x50 [ 61.807171] [] ? virtscsi_complete_cmd+0x800/0x800 [ 61.813927] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 61.820970] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 61.827264] [] scsi_finish_command+0x3a4/0x520 [ 61.833597] [] scsi_softirq_done+0x259/0x370 [ 61.839626] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 61.846438] [] blk_done_softirq+0x258/0x3a0 [ 61.852377] [] ? trigger_softirq+0x210/0x210 [ 61.858547] [] __do_softirq+0x226/0xa3f [ 61.864275] [] irq_exit+0x10a/0x150 [ 61.869762] [] do_IRQ+0x111/0x1d0 [ 61.874970] [] common_interrupt+0x9d/0x9d [ 61.881111] [] ? native_safe_halt+0x2/0x10 [ 61.888112] [] ? default_idle+0x56/0x3d0 [ 61.893918] [] arch_cpu_idle+0x10/0x20 [ 61.899429] [] default_idle_call+0x48/0x70 [ 61.905417] [] cpu_startup_entry+0x6d1/0x810 [ 61.911739] [] ? call_cpuidle+0xe0/0xe0 [ 61.917521] [] start_secondary+0x31d/0x410 [ 61.923571] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 61.930234] [ 61.931837] ================================= [ 61.936297] [ INFO: inconsistent lock state ] [ 61.940813] 4.4.169+ #1 Not tainted [ 61.944415] --------------------------------- [ 61.948875] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 61.955128] swapper/1/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 61.960377] (&sb->s_type->i_mutex_key#9){+.?.+.}, at: [] __generic_file_fsync+0xcf/0x1c0 [ 61.970950] {SOFTIRQ-ON-W} state was registered at: [ 61.976233] [] __lock_acquire+0xe73/0x4f50 [ 61.982558] [] lock_acquire+0x15e/0x450 [ 61.988483] [] mutex_lock_nested+0xc1/0xb80 [ 61.994632] [] prepare_binprm+0x2bf/0x770 [ 62.000908] [] do_execveat_common.isra.0+0xd86/0x1e90 [ 62.008054] [] SyS_execve+0x42/0x50 [ 62.013643] [] return_from_execve+0x0/0x23 [ 62.019709] irq event stamp: 292542 [ 62.023303] hardirqs last enabled at (292542): [] restore_regs_and_iret+0x0/0x1d [ 62.032827] hardirqs last disabled at (292541): [] common_interrupt+0x98/0x9d [ 62.041994] softirqs last enabled at (292506): [] _local_bh_enable+0x1c/0x50 [ 62.051506] softirqs last disabled at (292507): [] irq_exit+0x10a/0x150 [ 62.060028] [ 62.060028] other info that might help us debug this: [ 62.066812] Possible unsafe locking scenario: [ 62.066812] [ 62.072948] CPU0 [ 62.075645] ---- [ 62.078200] lock(&sb->s_type->i_mutex_key#9); [ 62.083483] [ 62.086214] lock(&sb->s_type->i_mutex_key#9); [ 62.091392] [ 62.091392] *** DEADLOCK *** [ 62.091392] [ 62.097546] no locks held by swapper/1/0. [ 62.101798] [ 62.101798] stack backtrace: [ 62.106268] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.4.169+ #1 [ 62.112578] 0000000000000000 a6abd3547db406d7 ffff8801db707610 ffffffff81aab9c1 [ 62.120565] 0000000000000090 ffff8801da6897c0 ffffffff83abd470 ffffffff84055ac0 [ 62.128593] ffff8801da68a0a8 ffff8801db707688 ffffffff813ad270 0000000000000001 [ 62.136698] Call Trace: [ 62.139449] [] dump_stack+0xc1/0x120 [ 62.145528] [] print_usage_bug.cold+0x454/0x592 [ 62.152131] [] ? save_stack_trace+0x26/0x50 [ 62.158442] [] mark_lock+0x6fd/0x1440 [ 62.163874] [] ? print_irq_inversion_bug+0x110/0x110 [ 62.170936] [] __lock_acquire+0x145e/0x4f50 [ 62.177081] [] ? retint_kernel+0x2d/0x2d [ 62.183376] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 62.190593] [] ? trace_hardirqs_on+0x10/0x10 [ 62.196631] [] ? dump_stack+0x105/0x120 [ 62.202392] [] lock_acquire+0x15e/0x450 [ 62.208135] [] ? __generic_file_fsync+0xcf/0x1c0 [ 62.214526] [] ? __generic_file_fsync+0xcf/0x1c0 [ 62.221178] [] mutex_lock_nested+0xc1/0xb80 [ 62.227129] [] ? __generic_file_fsync+0xcf/0x1c0 [ 62.233519] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 62.240502] [] ? replace_page_cache_page+0x420/0x420 [ 62.247228] [] ? mutex_trylock+0x500/0x500 [ 62.253346] [] ? filemap_check_errors+0x9d/0xe0 [ 62.259803] [] ? filemap_fdatawait_range+0x3d/0x50 [ 62.266489] [] __generic_file_fsync+0xcf/0x1c0 [ 62.273104] [] generic_file_fsync+0x78/0x120 [ 62.279267] [] ext4_sync_file+0x772/0xf10 [ 62.285160] [] ? mempool_kfree+0x20/0x20 [ 62.291020] [] ? ext4_llseek+0x970/0x970 [ 62.296866] [] vfs_fsync_range+0x111/0x260 [ 62.302884] [] dio_complete+0x3e6/0x720 [ 62.308600] [] dio_bio_end_aio+0x176/0x3f0 [ 62.314467] [] ? dio_complete+0x720/0x720 [ 62.320466] [] bio_endio+0x187/0x1e0 [ 62.325849] [] blk_update_request+0x267/0xa50 [ 62.332235] [] scsi_end_request+0x9c/0x5d0 [ 62.338583] [] scsi_io_completion+0x275/0x1810 [ 62.345173] [] ? trace_hardirqs_on+0x10/0x10 [ 62.351235] [] ? scsi_unblock_requests+0x50/0x50 [ 62.357869] [] ? virtscsi_complete_cmd+0x800/0x800 [ 62.364511] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 62.371408] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 62.377708] [] scsi_finish_command+0x3a4/0x520 [ 62.383909] [] scsi_softirq_done+0x259/0x370 [ 62.390283] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 62.397457] [] blk_done_softirq+0x258/0x3a0 [ 62.403445] [] ? trigger_softirq+0x210/0x210 [ 62.409820] [] __do_softirq+0x226/0xa3f [ 62.415422] [] irq_exit+0x10a/0x150 [ 62.420972] [] do_IRQ+0x111/0x1d0 [ 62.426204] [] common_interrupt+0x9d/0x9d [ 62.432228] [] ? native_safe_halt+0x2/0x10 [ 62.439526] [] ? default_idle+0x56/0x3d0 [ 62.445558] [] arch_cpu_idle+0x10/0x20 [ 62.451351] [] default_idle_call+0x48/0x70 [ 62.457369] [] cpu_startup_entry+0x6d1/0x810 [ 62.464192] [] ? call_cpuidle+0xe0/0xe0 [ 62.470304] [] start_secondary+0x31d/0x410 [ 62.476965] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 62.484099] BUG: scheduling while atomic: swapper/1/0/0x00000102 [ 62.490830] INFO: lockdep is turned off. [ 62.494875] Modules linked in: [ 62.498293] Preemption disabled at:[] cpu_startup_entry+0x755/0x810 [ 62.506511] [ 62.508119] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.4.169+ #1 [ 62.514438] 0000000000000000 a6abd3547db406d7 ffff8801db707800 ffffffff81aab9c1 [ 62.522696] 0000000000000000 ffff8801da6897c0 0000000000000102 0000000000000001 [ 62.530921] 000000000001e880 ffff8801db707820 ffffffff813a6dc3 ffff8801db71e880 [ 62.539365] Call Trace: [ 62.542172] [] dump_stack+0xc1/0x120 [ 62.548523] [] __schedule_bug.cold+0x60/0x71 [ 62.554715] [] __schedule+0x118b/0x1ee0 [ 62.560401] [] ? dump_stack+0x10f/0x120 [ 62.566002] [] ? lock_acquire+0x19f/0x450 [ 62.571783] [] schedule+0x99/0x1d0 [ 62.576947] [] schedule_preempt_disabled+0x13/0x20 [ 62.583493] [] mutex_lock_nested+0x3c2/0xb80 [ 62.589640] [] ? __generic_file_fsync+0xcf/0x1c0 [ 62.596278] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 62.603403] [] ? mutex_trylock+0x500/0x500 [ 62.609733] [] ? filemap_fdatawait_range+0x3d/0x50 [ 62.616280] [] __generic_file_fsync+0xcf/0x1c0 [ 62.622500] [] generic_file_fsync+0x78/0x120 [ 62.629048] [] ext4_sync_file+0x772/0xf10 [ 62.634952] [] ? mempool_kfree+0x20/0x20 [ 62.640995] [] ? ext4_llseek+0x970/0x970 [ 62.646720] [] vfs_fsync_range+0x111/0x260 [ 62.652582] [] dio_complete+0x3e6/0x720 [ 62.658180] [] dio_bio_end_aio+0x176/0x3f0 [ 62.664167] [] ? dio_complete+0x720/0x720 [ 62.670289] [] bio_endio+0x187/0x1e0 [ 62.675955] [] blk_update_request+0x267/0xa50 [ 62.682112] [] scsi_end_request+0x9c/0x5d0 [ 62.688336] [] scsi_io_completion+0x275/0x1810 [ 62.694544] [] ? trace_hardirqs_on+0x10/0x10 [ 62.700782] [] ? scsi_unblock_requests+0x50/0x50 [ 62.707286] [] ? virtscsi_complete_cmd+0x800/0x800 [ 62.713842] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 62.720878] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 62.727446] [] scsi_finish_command+0x3a4/0x520 [ 62.733978] [] scsi_softirq_done+0x259/0x370 [ 62.740131] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 62.747104] [] blk_done_softirq+0x258/0x3a0 [ 62.753326] [] ? trigger_softirq+0x210/0x210 [ 62.759580] [] __do_softirq+0x226/0xa3f [ 62.765312] [] irq_exit+0x10a/0x150 [ 62.770660] [] do_IRQ+0x111/0x1d0 [ 62.776029] [] common_interrupt+0x9d/0x9d [ 62.782036] [] ? native_safe_halt+0x2/0x10 [ 62.788654] [] ? default_idle+0x56/0x3d0 [ 62.794346] [] arch_cpu_idle+0x10/0x20 [ 62.800128] [] default_idle_call+0x48/0x70 [ 62.806547] [] cpu_startup_entry+0x6d1/0x810 [ 62.812575] [] ? call_cpuidle+0xe0/0xe0 [ 62.818486] [] start_secondary+0x31d/0x410 [ 62.824432] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 62.831282] bad: scheduling from the idle thread! [ 62.836361] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.4.169+ #1 [ 62.843988] 0000000000000000 a6abd3547db406d7 ffff8801db7077d0 ffffffff81aab9c1 [ 62.852403] ffffffff828463c0 ffff8801db71e880 ffff8801db71e880 0000000000000001 [ 62.860660] 0000000ea1091c9c ffff8801db7077e8 ffffffff8117ba0f ffff8801da6897c0 [ 62.868849] Call Trace: [ 62.871401] [] dump_stack+0xc1/0x120 [ 62.877821] [] dequeue_task_idle+0x1f/0x30 [ 62.883799] [] deactivate_task+0x229/0x2e0 [ 62.889660] [] __schedule+0x8e4/0x1ee0 [ 62.895283] [] ? dump_stack+0x10f/0x120 [ 62.900881] [] ? lock_acquire+0x19f/0x450 [ 62.906885] [] schedule+0x99/0x1d0 [ 62.912055] [] schedule_preempt_disabled+0x13/0x20 [ 62.918609] [] mutex_lock_nested+0x3c2/0xb80 [ 62.924775] [] ? __generic_file_fsync+0xcf/0x1c0 [ 62.931258] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 62.938249] [] ? mutex_trylock+0x500/0x500 [ 62.944463] [] ? filemap_fdatawait_range+0x3d/0x50 [ 62.951159] [] __generic_file_fsync+0xcf/0x1c0 [ 62.957883] [] generic_file_fsync+0x78/0x120 [ 62.957894] [] ext4_sync_file+0x772/0xf10 ** 433 printk messages dropped ** [ 62.962888] [] ? ext4_llseek+0x970/0x970 ** 2378 printk messages dropped ** [ 62.971924] [] dio_bio_end_aio+0x176/0x3f0 ** 2322 printk messages dropped ** [ 62.980941] [] ? dio_complete+0x720/0x720 ** 1070 printk messages dropped ** [ 62.985044] [] ? filemap_fdatawait_range+0x3d/0x50 ** 1951 printk messages dropped ** [ 62.999673] [] dio_bio_end_aio+0x176/0x3f0 ** 1932 printk messages dropped ** [ 63.008936] [] ? __generic_file_fsync+0xcf/0x1c0 ** 73 printk messages dropped ** [ 63.010189] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 63.010193] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 63.010196] [] scsi_finish_command+0x3a4/0x520 [ 63.010200] [] scsi_softirq_done+0x259/0x370 [ 63.010203] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 63.010212] [] blk_done_softirq+0x258/0x3a0 [ 63.010215] [] ? trigger_softirq+0x210/0x210 [ 63.010219] [] __do_softirq+0x226/0xa3f [ 63.010222] [] irq_exit+0x10a/0x150 [ 63.010225] [] do_IRQ+0x111/0x1d0 [ 63.010229] [] common_interrupt+0x9d/0x9d [ 63.010233] [] ? native_safe_halt+0x2/0x10 [ 63.010237] [] ? default_idle+0x56/0x3d0 [ 63.010241] [] arch_cpu_idle+0x10/0x20 [ 63.010244] [] default_idle_call+0x48/0x70 [ 63.010248] [] cpu_startup_entry+0x6d1/0x810 [ 63.010251] [] ? call_cpuidle+0xe0/0xe0 [ 63.010254] [] start_secondary+0x31d/0x410 [ 63.010257] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 63.010260] bad: scheduling from the idle thread! [ 63.010263] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.4.169+ #1 [ 63.010267] 0000000000000000 a6abd3547db406d7 ffff8801db7077d0 ffffffff81aab9c1 [ 63.010271] ffffffff828463c0 ffff8801db71e880 ffff8801db71e880 0000000000000001 [ 63.010275] 0000000eabb442fc ffff8801db7077e8 ffffffff8117ba0f ffff8801da6897c0 [ 63.010276] Call Trace: [ 63.010280] [] dump_stack+0xc1/0x120 [ 63.010284] [] dequeue_task_idle+0x1f/0x30 [ 63.010287] [] deactivate_task+0x229/0x2e0 [ 63.010290] [] __schedule+0x8e4/0x1ee0 [ 63.010293] [] ? dump_stack+0x10f/0x120 [ 63.010296] [] ? lock_acquire+0x19f/0x450 [ 63.010300] [] schedule+0x99/0x1d0 [ 63.010303] [] schedule_preempt_disabled+0x13/0x20 [ 63.010307] [] mutex_lock_nested+0x3c2/0xb80 [ 63.010310] [] ? __generic_file_fsync+0xcf/0x1c0 [ 63.010314] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 63.010318] [] ? mutex_trylock+0x500/0x500 [ 63.010321] [] ? filemap_fdatawait_range+0x3d/0x50 [ 63.010325] [] __generic_file_fsync+0xcf/0x1c0 [ 63.010328] [] generic_file_fsync+0x78/0x120 [ 63.010332] [] ext4_sync_file+0x772/0xf10 [ 63.010335] [] ? mempool_kfree+0x20/0x20 [ 63.010338] [] ? ext4_llseek+0x970/0x970 [ 63.010341] [] vfs_fsync_range+0x111/0x260 [ 63.010344] [] dio_complete+0x3e6/0x720 [ 63.010347] [] dio_bio_end_aio+0x176/0x3f0 [ 63.010350] [] ? dio_complete+0x720/0x720 [ 63.010354] [] bio_endio+0x187/0x1e0 [ 63.010357] [] blk_update_request+0x267/0xa50 [ 63.010360] [] scsi_end_request+0x9c/0x5d0 [ 63.010364] [] scsi_io_completion+0x275/0x1810 [ 63.010367] [] ? trace_hardirqs_on+0x10/0x10 [ 63.010371] [] ? scsi_unblock_requests+0x50/0x50 [ 63.010374] [] ? virtscsi_complete_cmd+0x800/0x800 [ 63.010378] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 63.010382] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 63.010385] [] scsi_finish_command+0x3a4/0x520 [ 63.010389] [] scsi_softirq_done+0x259/0x370 [ 63.010392] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 63.010395] [] blk_done_softirq+0x258/0x3a0 [ 63.010399] [] ? trigger_softirq+0x210/0x210 [ 63.010402] [] __do_softirq+0x226/0xa3f [ 63.010406] [] irq_exit+0x10a/0x150 [ 63.010409] [] do_IRQ+0x111/0x1d0 [ 63.010412] [] common_interrupt+0x9d/0x9d [ 63.010416] [] ? native_safe_halt+0x2/0x10 [ 63.010420] [] ? default_idle+0x56/0x3d0 [ 63.010423] [] arch_cpu_idle+0x10/0x20 [ 63.010427] [] default_idle_call+0x48/0x70 [ 63.010430] [] cpu_startup_entry+0x6d1/0x810 [ 63.010434] [] ? call_cpuidle+0xe0/0xe0 [ 63.010437] [] start_secondary+0x31d/0x410 [ 63.010440] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 63.010442] bad: scheduling from the idle thread! [ 63.010445] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.4.169+ #1 [ 63.010449] 0000000000000000 a6abd3547db406d7 ffff8801db7077d0 ffffffff81aab9c1 [ 63.010453] ffffffff828463c0 ffff8801db71e880 ffff8801db71e880 0000000000000001 [ 63.010457] 0000000eabb70a70 ffff8801db7077e8 ffffffff8117ba0f ffff8801da6897c0 [ 63.010458] Call Trace: [ 63.010462] [] dump_stack+0xc1/0x120 [ 63.010466] [] dequeue_task_idle+0x1f/0x30 [ 63.010469] [] deactivate_task+0x229/0x2e0 [ 63.010472] [] __schedule+0x8e4/0x1ee0 [ 63.010475] [] ? dump_stack+0x10f/0x120 [ 63.010479] [] ? lock_acquire+0x19f/0x450 [ 63.010482] [] schedule+0x99/0x1d0 [ 63.010485] [] schedule_preempt_disabled+0x13/0x20 [ 63.010489] [] mutex_lock_nested+0x3c2/0xb80 [ 63.010492] [] ? __generic_file_fsync+0xcf/0x1c0 [ 63.010496] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 63.010500] [] ? mutex_trylock+0x500/0x500 [ 63.010503] [] ? filemap_fdatawait_range+0x3d/0x50 [ 63.010507] [] __generic_file_fsync+0xcf/0x1c0 [ 63.010510] [] generic_file_fsync+0x78/0x120 [ 63.010514] [] ext4_sync_file+0x772/0xf10 [ 63.010517] [] ? mempool_kfree+0x20/0x20 [ 63.010520] [] ? ext4_llseek+0x970/0x970 [ 63.010524] [] vfs_fsync_range+0x111/0x260 [ 63.010526] [] dio_complete+0x3e6/0x720 [ 63.010530] [] dio_bio_end_aio+0x176/0x3f0 [ 63.010532] [] ? dio_complete+0x720/0x720 [ 63.010536] [] bio_endio+0x187/0x1e0 [ 63.010539] [] blk_update_request+0x267/0xa50 [ 63.010542] [] scsi_end_request+0x9c/0x5d0 [ 63.010546] [] scsi_io_completion+0x275/0x1810 [ 63.010549] [] ? trace_hardirqs_on+0x10/0x10 [ 63.010553] [] ? scsi_unblock_requests+0x50/0x50 [ 63.010556] [] ? virtscsi_complete_cmd+0x800/0x800 [ 63.010560] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 63.010564] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 63.010567] [] scsi_finish_command+0x3a4/0x520 [ 63.010571] [] scsi_softirq_done+0x259/0x370 [ 63.010574] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 63.010577] [] blk_done_softirq+0x258/0x3a0 [ 63.010581] [] ? trigger_softirq+0x210/0x210 [ 63.010584] [] __do_softirq+0x226/0xa3f [ 63.010588] [] irq_exit+0x10a/0x150 [ 63.010591] [] do_IRQ+0x111/0x1d0 [ 63.010594] [] common_interrupt+0x9d/0x9d [ 63.010598] [] ? native_safe_halt+0x2/0x10 [ 63.010602] [] ? default_idle+0x56/0x3d0 [ 63.010605] [] arch_cpu_idle+0x10/0x20 [ 63.010609] [] default_idle_call+0x48/0x70 [ 63.010612] [] cpu_startup_entry+0x6d1/0x810 [ 63.010615] [] ? call_cpuidle+0xe0/0xe0 [ 63.010619] [] start_secondary+0x31d/0x410 [ 63.010622] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 63.010624] bad: scheduling from the idle thread! [ 63.010627] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.4.169+ #1 [ 63.010631] 0000000000000000 a6abd3547db406d7 ffff8801db7077d0 ffffffff81aab9c1 [ 63.010635] ffffffff828463c0 ffff8801db71e880 ffff8801db71e880 0000000000000001 [ 63.010639] 0000000eabb9d170 ffff8801db7077e8 ffffffff8117ba0f ffff8801da6897c0 [ 63.010639] Call Trace: [ 63.010644] [] dump_stack+0xc1/0x120 [ 63.010647] [] dequeue_task_idle+0x1f/0x30 [ 63.010650] [] deactivate_task+0x229/0x2e0 [ 63.010654] [] __schedule+0x8e4/0x1ee0 [ 63.010657] [] ? dump_stack+0x10f/0x120 [ 63.010660] [] ? lock_acquire+0x19f/0x450 [ 63.010663] [] schedule+0x99/0x1d0 [ 63.010667] [] schedule_preempt_disabled+0x13/0x20 [ 63.010670] [] mutex_lock_nested+0x3c2/0xb80 [ 63.010674] [] ? __generic_file_fsync+0xcf/0x1c0 [ 63.010677] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 63.010681] [] ? mutex_trylock+0x500/0x500 [ 63.010685] [] ? filemap_fdatawait_range+0x3d/0x50 [ 63.010688] [] __generic_file_fsync+0xcf/0x1c0 [ 63.010692] [] generic_file_fsync+0x78/0x120 [ 63.010695] [] ext4_sync_file+0x772/0xf10 [ 63.010698] [] ? mempool_kfree+0x20/0x20 [ 63.010702] [] ? ext4_llseek+0x970/0x970 [ 63.010705] [] vfs_fsync_range+0x111/0x260 [ 63.010710] [] dio_complete+0x3e6/0x720 [ 63.010713] [] dio_bio_end_aio+0x176/0x3f0 [ 63.010716] [] ? dio_complete+0x720/0x720 [ 63.010719] [] bio_endio+0x187/0x1e0 [ 63.010722] [] blk_update_request+0x267/0xa50 [ 63.010725] [] scsi_end_request+0x9c/0x5d0 [ 63.010729] [] scsi_io_completion+0x275/0x1810 [ 63.010732] [] ? trace_hardirqs_on+0x10/0x10 [ 63.010736] [] ? scsi_unblock_requests+0x50/0x50 [ 63.010740] [] ? virtscsi_complete_cmd+0x800/0x800 [ 63.010743] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 63.010747] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 63.010750] [] scsi_finish_command+0x3a4/0x520 [ 63.010754] [] scsi_softirq_done+0x259/0x370 [ 63.010757] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 63.010760] [] blk_done_softirq+0x258/0x3a0 [ 63.010764] [] ? trigger_softirq+0x210/0x210 [ 63.010767] [] __do_softirq+0x226/0xa3f [ 63.010771] [] irq_exit+0x10a/0x150 [ 63.010774] [] do_IRQ+0x111/0x1d0 [ 63.010777] [] common_interrupt+0x9d/0x9d [ 63.010781] [] ? native_safe_halt+0x2/0x10 [ 63.010785] [] ? default_idle+0x56/0x3d0 [ 63.010788] [] arch_cpu_idle+0x10/0x20 [ 63.010792] [] default_idle_call+0x48/0x70 [ 63.010795] [] cpu_startup_entry+0x6d1/0x810 [ 63.010799] [] ? call_cpuidle+0xe0/0xe0 [ 63.010802] [] start_secondary+0x31d/0x410 [ 63.010805] [] ? set_cpu_sibling_map+0x10d0/0x10d0 [ 63.010807] bad: scheduling from the idle thread! [ 63.010810] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.4.169+ #1 [ 63.010814] 0000000000000000 a6abd3547db406d7 ffff8801db7077d0 ffffffff81aab9c1 [ 63.010818] ffffffff828463c0 ffff8801db71e880 ffff8801db71e880 0000000000000001 [ 63.010822] 0000000eabbc9c34 ffff8801db7077e8 ffffffff8117ba0f ffff8801da6897c0 [ 63.010823] Call Trace: [ 63.010827] [] dump_stack+0xc1/0x120 [ 63.010830] [] dequeue_task_idle+0x1f/0x30 [ 63.010833] [] deactivate_task+0x229/0x2e0 [ 63.010837] [] __schedule+0x8e4/0x1ee0 [ 63.010840] [] ? dump_stack+0x10f/0x120 [ 63.010843] [] ? lock_acquire+0x19f/0x450 [ 63.010846] [] schedule+0x99/0x1d0 [ 63.010850] [] schedule_preempt_disabled+0x13/0x20 [ 63.010853] [] mutex_lock_nested+0x3c2/0xb80 [ 63.010857] [] ? __generic_file_fsync+0xcf/0x1c0 [ 63.010860] [] ? __filemap_fdatawrite_range+0x1b5/0x260 [ 63.010864] [] ? mutex_trylock+0x500/0x500 [ 63.010868] [] ? filemap_fdatawait_range+0x3d/0x50 [ 63.010871] [] __generic_file_fsync+0xcf/0x1c0 [ 63.010874] [] generic_file_fsync+0x78/0x120 [ 63.010878] [] ext4_sync_file+0x772/0xf10 [ 63.010881] [] ? mempool_kfree+0x20/0x20 [ 63.010885] [] ? ext4_llseek+0x970/0x970 [ 63.010888] [] vfs_fsync_range+0x111/0x260 [ 63.010891] [] dio_complete+0x3e6/0x720 [ 63.010894] [] dio_bio_end_aio+0x176/0x3f0 [ 63.010897] [] ? dio_complete+0x720/0x720 [ 63.010900] [] bio_endio+0x187/0x1e0 [ 63.010903] [] blk_update_request+0x267/0xa50 [ 63.010907] [] scsi_end_request+0x9c/0x5d0 [ 63.010910] [] scsi_io_completion+0x275/0x1810 [ 63.010913] [] ? trace_hardirqs_on+0x10/0x10 [ 63.010920] [] ? scsi_unblock_requests+0x50/0x50 [ 63.010924] [] ? virtscsi_complete_cmd+0x800/0x800 [ 63.010928] [] ? scsi_handle_queue_ramp_up+0x32a/0x430 [ 63.010931] [] ? sd_completed_bytes+0x3e0/0x3e0 [ 63.010935] [] scsi_finish_command+0x3a4/0x520 [ 63.010938] [] scsi_softirq_done+0x259/0x370 [ 63.010941] [] ? trace_hardirqs_on_caller+0x260/0x5a0 [ 63.010945] [] blk_done_softirq+0x258/0x3a0 [ 63.010948] [] ? trigger_softirq+0x210/0x210 [ 63.010952] [] __do_softirq+0x226/0xa3f [ 63.010955] [] irq_exit+0x10a/0x150 [ 63.010958] [