[btrfs] lockdep splat
From: Mike Galbraith
Date: Fri Feb 17 2017 - 16:14:48 EST
Greetings,
Running ltp on master.today, I received the splat (from hell) below.
[ 5015.128458] =========================================================
[ 5015.128458] [ INFO: possible irq lock inversion dependency detected ]
[ 5015.128458] 4.10.0-default #119 Tainted: G E
[ 5015.128458] ---------------------------------------------------------
[ 5015.128458] khugepaged/896 just changed the state of lock:
[ 5015.128458] (&delayed_node->mutex){+.+.-.}, at: [<ffffffffa047b021>] __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5015.128458] but this lock took another, RECLAIM_FS-unsafe lock in the past:
[ 5015.128458] (pcpu_alloc_mutex){+.+.+.}
[ 5015.128458]
[ 5015.128458]
[ 5015.128458] and interrupts could create inverse lock ordering between them.
[ 5015.128458]
[ 5015.128458]
[ 5015.128458] other info that might help us debug this:
[ 5015.128458] Chain exists of:
[ 5015.128458] &delayed_node->mutex --> &found->groups_sem --> pcpu_alloc_mutex
[ 5015.128458]
[ 5015.128458] Possible interrupt unsafe locking scenario:
[ 5015.128458]
[ 5015.128458] CPU0 CPU1
[ 5015.128458] ---- ----
[ 5015.128458] lock(pcpu_alloc_mutex);
[ 5015.128458] local_irq_disable();
[ 5015.128458] lock(&delayed_node->mutex);
[ 5015.128458] lock(&found->groups_sem);
[ 5015.128458] <Interrupt>
[ 5015.128458] lock(&delayed_node->mutex);
[ 5015.128458]
[ 5015.128458] *** DEADLOCK ***
[ 5015.128458]
[ 5015.128458] 2 locks held by khugepaged/896:
[ 5015.128458] #0: (shrinker_rwsem){++++..}, at: [<ffffffff812029bd>] shrink_slab+0x7d/0x650
[ 5015.128458] #1: (&type->s_umount_key#26){++++..}, at: [<ffffffff8128d4db>] trylock_super+0x1b/0x50
[ 5015.128458]
[ 5015.128458] the shortest dependencies between 2nd lock and 1st lock:
[ 5015.128458] -> (pcpu_alloc_mutex){+.+.+.} ops: 4652 {
[ 5015.128458] HARDIRQ-ON-W at:
[ 5015.128458] __lock_acquire+0x8e6/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] mutex_lock_nested+0x67/0x6a0
[ 5015.128458] pcpu_alloc+0x1c0/0x600
[ 5015.128458] __alloc_percpu+0x15/0x20
[ 5015.128458] alloc_kmem_cache_cpus.isra.56+0x2b/0xa0
[ 5015.128458] __do_tune_cpucache+0x30/0x210
[ 5015.128458] do_tune_cpucache+0x2a/0xd0
[ 5015.128458] enable_cpucache+0x61/0x110
[ 5015.128458] kmem_cache_init_late+0x41/0x76
[ 5015.128458] start_kernel+0x352/0x4cd
[ 5015.128458] x86_64_start_reservations+0x2a/0x2c
[ 5015.128458] x86_64_start_kernel+0x13d/0x14c
[ 5015.128458] verify_cpu+0x0/0xfc
[ 5015.128458] SOFTIRQ-ON-W at:
[ 5015.128458] __lock_acquire+0x283/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] mutex_lock_nested+0x67/0x6a0
[ 5015.128458] pcpu_alloc+0x1c0/0x600
[ 5015.128458] __alloc_percpu+0x15/0x20
[ 5015.128458] alloc_kmem_cache_cpus.isra.56+0x2b/0xa0
[ 5015.128458] __do_tune_cpucache+0x30/0x210
[ 5015.128458] do_tune_cpucache+0x2a/0xd0
[ 5015.128458] enable_cpucache+0x61/0x110
[ 5015.128458] kmem_cache_init_late+0x41/0x76
[ 5015.128458] start_kernel+0x352/0x4cd
[ 5015.128458] x86_64_start_reservations+0x2a/0x2c
[ 5015.128458] x86_64_start_kernel+0x13d/0x14c
[ 5015.128458] verify_cpu+0x0/0xfc
[ 5015.128458] RECLAIM_FS-ON-W at:
[ 5015.128458] mark_held_locks+0x66/0x90
[ 5015.128458] lockdep_trace_alloc+0x6f/0xd0
[ 5015.128458] __alloc_pages_nodemask+0x81/0x370
[ 5015.128458] pcpu_populate_chunk+0xac/0x340
[ 5015.128458] pcpu_alloc+0x4f8/0x600
[ 5015.128458] __alloc_percpu+0x15/0x20
[ 5015.128458] perf_pmu_register+0xc6/0x3c0
[ 5015.128458] init_hw_perf_events+0x513/0x56d
[ 5015.128458] do_one_initcall+0x51/0x1c0
[ 5015.128458] kernel_init_freeable+0x146/0x28e
[ 5015.128458] kernel_init+0xe/0x110
[ 5015.128458] ret_from_fork+0x31/0x40
[ 5015.128458] INITIAL USE at:
[ 5015.128458] __lock_acquire+0x2ce/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] mutex_lock_nested+0x67/0x6a0
[ 5015.128458] pcpu_alloc+0x1c0/0x600
[ 5015.128458] __alloc_percpu+0x15/0x20
[ 5015.128458] alloc_kmem_cache_cpus.isra.56+0x2b/0xa0
[ 5015.128458] setup_cpu_cache+0x34/0x220
[ 5015.128458] __kmem_cache_create+0x188/0x210
[ 5015.128458] create_boot_cache+0x87/0xaf
[ 5015.128458] kmem_cache_init+0xa2/0x191
[ 5015.128458] start_kernel+0x265/0x4cd
[ 5015.128458] x86_64_start_reservations+0x2a/0x2c
[ 5015.128458] x86_64_start_kernel+0x13d/0x14c
[ 5015.128458] verify_cpu+0x0/0xfc
[ 5015.128458] }
[ 5015.128458] ... key at: [<ffffffff81ceae60>] pcpu_alloc_mutex+0x60/0x80
[ 5015.128458] ... acquired at:
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] mutex_lock_nested+0x67/0x6a0
[ 5015.128458] pcpu_alloc+0x1c0/0x600
[ 5015.128458] __alloc_percpu_gfp+0x12/0x20
[ 5015.128458] __percpu_counter_init+0x55/0xd0
[ 5015.128458] btrfs_init_fs_root+0x9e/0x1c0 [btrfs]
[ 5015.128458] btrfs_get_fs_root.part.54+0x5f/0x150 [btrfs]
[ 5015.128458] btrfs_get_fs_root+0x44/0xa0 [btrfs]
[ 5015.128458] __resolve_indirect_refs+0x13f/0x840 [btrfs]
[ 5015.128458] find_parent_nodes+0x540/0x8d0 [btrfs]
[ 5015.128458] __btrfs_find_all_roots+0xc6/0x130 [btrfs]
[ 5015.128458] btrfs_find_all_roots+0x55/0x70 [btrfs]
[ 5015.128458] btrfs_qgroup_prepare_account_extents+0x58/0xa0 [btrfs]
[ 5015.128458] btrfs_commit_transaction+0x3c1/0xa50 [btrfs]
[ 5015.128458] transaction_kthread+0x19f/0x1e0 [btrfs]
[ 5015.128458] kthread+0x10c/0x140
[ 5015.128458] ret_from_fork+0x31/0x40
[ 5015.128458]
[ 5015.128458] -> (&fs_info->commit_root_sem){++++..} ops: 542968 {
[ 5015.128458] HARDIRQ-ON-W at:
[ 5015.128458] __lock_acquire+0x8e6/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] down_write+0x44/0x80
[ 5015.128458] cache_block_group+0x287/0x3e0 [btrfs]
[ 5015.128458] find_free_extent.isra.66+0x117f/0x1430 [btrfs]
[ 5015.128458] btrfs_reserve_extent+0xe4/0x1a0 [btrfs]
[ 5015.128458] __btrfs_prealloc_file_range+0x121/0x470 [btrfs]
[ 5015.128458] btrfs_prealloc_file_range_trans+0x30/0x40 [btrfs]
[ 5015.128458] cache_save_setup+0x282/0x3c0 [btrfs]
[ 5015.128458] btrfs_start_dirty_block_groups+0x1ec/0x480 [btrfs]
[ 5015.128458] btrfs_commit_transaction+0x13d/0xa50 [btrfs]
[ 5015.128458] transaction_kthread+0x19f/0x1e0 [btrfs]
[ 5015.128458] kthread+0x10c/0x140
[ 5015.128458] ret_from_fork+0x31/0x40
[ 5015.128458] HARDIRQ-ON-R at:
[ 5015.128458] __lock_acquire+0x260/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] down_read+0x47/0x70
[ 5015.128458] caching_thread+0x63/0x4d0 [btrfs]
[ 5015.128458] normal_work_helper+0x19d/0x6c0 [btrfs]
[ 5015.128458] btrfs_cache_helper+0x12/0x20 [btrfs]
[ 5015.128458] process_one_work+0x1e1/0x6b0
[ 5015.128458] worker_thread+0x137/0x4b0
[ 5015.128458] kthread+0x10c/0x140
[ 5015.128458] ret_from_fork+0x31/0x40
[ 5015.128458] SOFTIRQ-ON-W at:
[ 5015.128458] __lock_acquire+0x283/0x1550
[ 5015.128458] lock_acquire+0xbd/0x220
[ 5015.128458] down_write+0x44/0x80
[ 5015.128458] cache_block_group+0x287/0x3e0 [btrfs]
[ 5015.128458] find_free_extent.isra.66+0x117f/0x1430 [btrfs]
[ 5015.128458] btrfs_reserve_extent+0xe4/0x1a0 [btrfs]
[ 5015.128458] __btrfs_prealloc_file_range+0x121/0x470 [btrfs]
[ 5015.128458] btrfs_prealloc_file_range_trans+0x30/0x40 [btrfs]
[ 5015.128458] cache_save_setup+0x282/0x3c0 [btrfs]
[ 5015.128458] btrfs_start_dirty_block_groups+0x1ec/0x480 [btrfs]
[ 5015.128458] btrfs_commit_transaction+0x13d/0xa50 [btrfs]
[ 5015.128458] transaction_kthread+0x19f/0x1e0 [btrfs]
[ 5015.128458] kthread+0x10c/0x140
[ 5015.128458] ret_from_fork+0x31/0x40
[ 5017.004646] SOFTIRQ-ON-R at:
[ 5017.004646] __lock_acquire+0x283/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_read+0x47/0x70
[ 5017.004646] caching_thread+0x63/0x4d0 [btrfs]
[ 5017.004646] normal_work_helper+0x19d/0x6c0 [btrfs]
[ 5017.004646] btrfs_cache_helper+0x12/0x20 [btrfs]
[ 5017.004646] process_one_work+0x1e1/0x6b0
[ 5017.004646] worker_thread+0x137/0x4b0
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5017.004646] INITIAL USE at:
[ 5017.004646] __lock_acquire+0x2ce/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_write+0x44/0x80
[ 5017.004646] cache_block_group+0x287/0x3e0 [btrfs]
[ 5017.004646] find_free_extent.isra.66+0x117f/0x1430 [btrfs]
[ 5017.004646] btrfs_reserve_extent+0xe4/0x1a0 [btrfs]
[ 5017.004646] __btrfs_prealloc_file_range+0x121/0x470 [btrfs]
[ 5017.004646] btrfs_prealloc_file_range_trans+0x30/0x40 [btrfs]
[ 5017.004646] cache_save_setup+0x282/0x3c0 [btrfs]
[ 5017.004646] btrfs_start_dirty_block_groups+0x1ec/0x480 [btrfs]
[ 5017.004646] btrfs_commit_transaction+0x13d/0xa50 [btrfs]
[ 5017.004646] transaction_kthread+0x19f/0x1e0 [btrfs]
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5017.004646] }
[ 5017.004646] ... key at: [<ffffffffa04cd0f0>] __key.58871+0x0/0xfffffffffffd8f10 [btrfs]
[ 5017.004646] ... acquired at:
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_write+0x44/0x80
[ 5017.004646] cache_block_group+0x287/0x3e0 [btrfs]
[ 5017.004646] find_free_extent.isra.66+0x117f/0x1430 [btrfs]
[ 5017.004646] btrfs_reserve_extent+0xe4/0x1a0 [btrfs]
[ 5017.004646] __btrfs_prealloc_file_range+0x121/0x470 [btrfs]
[ 5017.004646] btrfs_prealloc_file_range_trans+0x30/0x40 [btrfs]
[ 5017.004646] cache_save_setup+0x282/0x3c0 [btrfs]
[ 5017.004646] btrfs_start_dirty_block_groups+0x1ec/0x480 [btrfs]
[ 5017.004646] btrfs_commit_transaction+0x13d/0xa50 [btrfs]
[ 5017.004646] transaction_kthread+0x19f/0x1e0 [btrfs]
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5017.004646]
[ 5017.004646] -> (&found->groups_sem){++++..} ops: 744551 {
[ 5017.004646] HARDIRQ-ON-W at:
[ 5017.004646] __lock_acquire+0x8e6/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_write+0x44/0x80
[ 5017.004646] __link_block_group+0x42/0x160 [btrfs]
[ 5017.004646] btrfs_read_block_groups+0x36d/0x810 [btrfs]
[ 5017.004646] open_ctree+0x2281/0x2930 [btrfs]
[ 5017.004646] btrfs_mount+0xca8/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] btrfs_mount+0x18b/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] do_mount+0x1cf/0xcf0
[ 5017.004646] SyS_mount+0x83/0xd0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] HARDIRQ-ON-R at:
[ 5017.004646] __lock_acquire+0x260/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_read+0x47/0x70
[ 5017.004646] btrfs_calc_num_tolerated_disk_barrier_failures+0x121/0x200 [btrfs]
[ 5017.004646] open_ctree+0x22b0/0x2930 [btrfs]
[ 5017.004646] btrfs_mount+0xca8/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] btrfs_mount+0x18b/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] do_mount+0x1cf/0xcf0
[ 5017.004646] SyS_mount+0x83/0xd0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] SOFTIRQ-ON-W at:
[ 5017.004646] __lock_acquire+0x283/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_write+0x44/0x80
[ 5017.004646] __link_block_group+0x42/0x160 [btrfs]
[ 5017.004646] btrfs_read_block_groups+0x36d/0x810 [btrfs]
[ 5017.004646] open_ctree+0x2281/0x2930 [btrfs]
[ 5017.004646] btrfs_mount+0xca8/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] btrfs_mount+0x18b/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] do_mount+0x1cf/0xcf0
[ 5017.004646] SyS_mount+0x83/0xd0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] SOFTIRQ-ON-R at:
[ 5017.004646] __lock_acquire+0x283/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_read+0x47/0x70
[ 5017.004646] btrfs_calc_num_tolerated_disk_barrier_failures+0x121/0x200 [btrfs]
[ 5017.004646] open_ctree+0x22b0/0x2930 [btrfs]
[ 5017.004646] btrfs_mount+0xca8/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] btrfs_mount+0x18b/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] do_mount+0x1cf/0xcf0
[ 5017.004646] SyS_mount+0x83/0xd0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] INITIAL USE at:
[ 5017.004646] __lock_acquire+0x2ce/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_write+0x44/0x80
[ 5017.004646] __link_block_group+0x42/0x160 [btrfs]
[ 5017.004646] btrfs_read_block_groups+0x36d/0x810 [btrfs]
[ 5017.004646] open_ctree+0x2281/0x2930 [btrfs]
[ 5017.004646] btrfs_mount+0xca8/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] btrfs_mount+0x18b/0xec0 [btrfs]
[ 5017.004646] mount_fs+0x39/0x170
[ 5017.004646] vfs_kern_mount+0x6b/0x170
[ 5017.004646] do_mount+0x1cf/0xcf0
[ 5017.004646] SyS_mount+0x83/0xd0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] }
[ 5017.004646] ... key at: [<ffffffffa04cd000>] __key.57207+0x0/0xfffffffffffd9000 [btrfs]
[ 5017.004646] ... acquired at:
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] down_read+0x47/0x70
[ 5017.004646] find_free_extent.isra.66+0xdca/0x1430 [btrfs]
[ 5017.004646] btrfs_reserve_extent+0xe4/0x1a0 [btrfs]
[ 5017.004646] btrfs_alloc_tree_block+0x198/0x4b0 [btrfs]
[ 5017.004646] __btrfs_cow_block+0x12f/0x610 [btrfs]
[ 5017.004646] btrfs_cow_block+0x11e/0x2c0 [btrfs]
[ 5017.004646] btrfs_search_slot+0x1df/0x970 [btrfs]
[ 5017.004646] btrfs_lookup_inode+0x2f/0xa0 [btrfs]
[ 5017.004646] __btrfs_update_delayed_inode+0x65/0x210 [btrfs]
[ 5017.004646] btrfs_commit_inode_delayed_inode+0x124/0x130 [btrfs]
[ 5017.004646] btrfs_evict_inode+0x459/0x700 [btrfs]
[ 5017.004646] evict+0xd1/0x1a0
[ 5017.004646] iput+0x263/0x300
[ 5017.004646] do_unlinkat+0x178/0x290
[ 5017.004646] SyS_unlink+0x16/0x20
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646]
[ 5017.004646] -> (&delayed_node->mutex){+.+.-.} ops: 17098868 {
[ 5017.004646] HARDIRQ-ON-W at:
[ 5017.004646] __lock_acquire+0x8e6/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] btrfs_delayed_update_inode+0x45/0x790 [btrfs]
[ 5017.004646] btrfs_update_inode+0x8c/0x110 [btrfs]
[ 5017.004646] btrfs_dirty_inode+0x69/0xe0 [btrfs]
[ 5017.004646] btrfs_update_time+0x64/0xc0 [btrfs]
[ 5017.004646] touch_atime+0x89/0xb0
[ 5017.004646] generic_file_read_iter+0x740/0x8c0
[ 5017.004646] __vfs_read+0xbe/0x130
[ 5017.004646] vfs_read+0x9e/0x170
[ 5017.004646] SyS_read+0x49/0xa0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] SOFTIRQ-ON-W at:
[ 5017.004646] __lock_acquire+0x283/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] btrfs_delayed_update_inode+0x45/0x790 [btrfs]
[ 5017.004646] btrfs_update_inode+0x8c/0x110 [btrfs]
[ 5017.004646] btrfs_dirty_inode+0x69/0xe0 [btrfs]
[ 5017.004646] btrfs_update_time+0x64/0xc0 [btrfs]
[ 5017.004646] touch_atime+0x89/0xb0
[ 5017.004646] generic_file_read_iter+0x740/0x8c0
[ 5017.004646] __vfs_read+0xbe/0x130
[ 5017.004646] vfs_read+0x9e/0x170
[ 5017.004646] SyS_read+0x49/0xa0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] IN-RECLAIM_FS-W at:
[ 5017.004646] __lock_acquire+0x2b6/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] btrfs_remove_delayed_node+0x2a/0x30 [btrfs]
[ 5017.004646] btrfs_evict_inode+0x355/0x700 [btrfs]
[ 5017.004646] evict+0xd1/0x1a0
[ 5017.004646] dispose_list+0x4d/0x70
[ 5017.004646] prune_icache_sb+0x4b/0x60
[ 5017.004646] super_cache_scan+0x141/0x190
[ 5017.004646] shrink_slab+0x261/0x650
[ 5017.004646] shrink_node+0x2e3/0x2f0
[ 5017.004646] do_try_to_free_pages+0xdf/0x340
[ 5017.004646] try_to_free_pages+0xf1/0x380
[ 5017.004646] __alloc_pages_slowpath+0x300/0xb30
[ 5017.004646] __alloc_pages_nodemask+0x239/0x370
[ 5017.004646] khugepaged_alloc_page+0x3d/0x70
[ 5017.004646] khugepaged_scan_mm_slot+0x5e2/0x2070
[ 5017.004646] khugepaged+0x2cb/0x570
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5017.004646] INITIAL USE at:
[ 5017.004646] __lock_acquire+0x2ce/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] btrfs_delayed_update_inode+0x45/0x790 [btrfs]
[ 5017.004646] btrfs_update_inode+0x8c/0x110 [btrfs]
[ 5017.004646] btrfs_dirty_inode+0x69/0xe0 [btrfs]
[ 5017.004646] btrfs_update_time+0x64/0xc0 [btrfs]
[ 5017.004646] touch_atime+0x89/0xb0
[ 5017.004646] generic_file_read_iter+0x740/0x8c0
[ 5017.004646] __vfs_read+0xbe/0x130
[ 5017.004646] vfs_read+0x9e/0x170
[ 5017.004646] SyS_read+0x49/0xa0
[ 5017.004646] entry_SYSCALL_64_fastpath+0x1f/0xc2
[ 5017.004646] }
[ 5017.004646] ... key at: [<ffffffffa04d0fa8>] __key.55028+0x0/0xfffffffffffd5058 [btrfs]
[ 5017.004646] ... acquired at:
[ 5017.004646] check_usage_forwards+0x131/0x140
[ 5017.004646] mark_lock+0x191/0x290
[ 5017.004646] __lock_acquire+0x2b6/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] btrfs_remove_delayed_node+0x2a/0x30 [btrfs]
[ 5017.004646] btrfs_evict_inode+0x355/0x700 [btrfs]
[ 5017.004646] evict+0xd1/0x1a0
[ 5017.004646] dispose_list+0x4d/0x70
[ 5017.004646] prune_icache_sb+0x4b/0x60
[ 5017.004646] super_cache_scan+0x141/0x190
[ 5017.004646] shrink_slab+0x261/0x650
[ 5017.004646] shrink_node+0x2e3/0x2f0
[ 5017.004646] do_try_to_free_pages+0xdf/0x340
[ 5017.004646] try_to_free_pages+0xf1/0x380
[ 5017.004646] __alloc_pages_slowpath+0x300/0xb30
[ 5017.004646] __alloc_pages_nodemask+0x239/0x370
[ 5017.004646] khugepaged_alloc_page+0x3d/0x70
[ 5017.004646] khugepaged_scan_mm_slot+0x5e2/0x2070
[ 5017.004646] khugepaged+0x2cb/0x570
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5017.004646]
[ 5017.004646]
[ 5017.004646] stack backtrace:
[ 5017.004646] CPU: 74 PID: 896 Comm: khugepaged Tainted: G E 4.10.0-default #119
[ 5017.004646] Hardware name: Intel Corporation BRICKLAND/BRICKLAND, BIOS BRHSXSD1.86B.0056.R01.1409242327 09/24/2014
[ 5017.004646] Call Trace:
[ 5017.004646] dump_stack+0x85/0xc9
[ 5017.004646] print_irq_inversion_bug.part.37+0x1ac/0x1b8
[ 5017.004646] check_usage_forwards+0x131/0x140
[ 5017.004646] ? check_usage_backwards+0x130/0x130
[ 5017.004646] mark_lock+0x191/0x290
[ 5017.004646] __lock_acquire+0x2b6/0x1550
[ 5017.004646] lock_acquire+0xbd/0x220
[ 5017.004646] ? __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] ? __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] mutex_lock_nested+0x67/0x6a0
[ 5017.004646] ? __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] ? btrfs_evict_inode+0x275/0x700 [btrfs]
[ 5017.004646] __btrfs_release_delayed_node+0x41/0x2d0 [btrfs]
[ 5017.004646] btrfs_remove_delayed_node+0x2a/0x30 [btrfs]
[ 5017.004646] btrfs_evict_inode+0x355/0x700 [btrfs]
[ 5017.004646] ? _raw_spin_unlock+0x31/0x50
[ 5017.004646] evict+0xd1/0x1a0
[ 5017.004646] dispose_list+0x4d/0x70
[ 5017.004646] prune_icache_sb+0x4b/0x60
[ 5017.004646] super_cache_scan+0x141/0x190
[ 5017.004646] shrink_slab+0x261/0x650
[ 5017.004646] shrink_node+0x2e3/0x2f0
[ 5017.004646] do_try_to_free_pages+0xdf/0x340
[ 5017.004646] try_to_free_pages+0xf1/0x380
[ 5017.004646] __alloc_pages_slowpath+0x300/0xb30
[ 5017.004646] ? get_page_from_freelist+0x110/0xbf0
[ 5017.004646] __alloc_pages_nodemask+0x239/0x370
[ 5017.004646] khugepaged_alloc_page+0x3d/0x70
[ 5017.004646] khugepaged_scan_mm_slot+0x5e2/0x2070
[ 5017.004646] ? prepare_to_wait_event+0x8c/0x170
[ 5017.004646] ? finish_wait+0x75/0x90
[ 5017.004646] khugepaged+0x2cb/0x570
[ 5017.004646] ? remove_wait_queue+0x60/0x60
[ 5017.004646] kthread+0x10c/0x140
[ 5017.004646] ? khugepaged_scan_mm_slot+0x2070/0x2070
[ 5017.004646] ? kthread_parkme+0x40/0x40
[ 5017.004646] ret_from_fork+0x31/0x40
[ 5258.166832] run invoked oom-killer: gfp_mask=0x1400840(GFP_NOFS|__GFP_NOFAIL), nodemask=0-3, order=0, oom_score_adj=0
[ 5258.190706] run cpuset=/ mems_allowed=0-3
[ 5258.199781] CPU: 3 PID: 117851 Comm: run Tainted: G E 4.10.0-default #119
[ 5258.203771] Hardware name: Intel Corporation BRICKLAND/BRICKLAND, BIOS BRHSXSD1.86B.0056.R01.1409242327 09/24/2014
[ 5258.203771] Call Trace:
[ 5258.203771] dump_stack+0x85/0xc9
[ 5258.203771] dump_header+0x82/0x275
[ 5258.203771] ? trace_hardirqs_on+0xd/0x10
[ 5258.203771] ? _raw_spin_unlock_irqrestore+0x4a/0x80
[ 5258.203771] oom_kill_process+0x219/0x400
[ 5258.203771] out_of_memory+0x108/0x560
[ 5258.203771] ? out_of_memory+0x1e1/0x560
[ 5258.203771] __alloc_pages_slowpath+0xa2d/0xb30
[ 5258.203771] ? get_page_from_freelist+0x110/0xbf0
[ 5258.203771] __alloc_pages_nodemask+0x239/0x370
[ 5258.203771] alloc_pages_current+0x97/0x1b0
[ 5258.203771] __page_cache_alloc+0x12f/0x160
[ 5258.203771] ? find_get_entry+0x5/0x270
[ 5258.203771] pagecache_get_page+0x59/0x250
[ 5258.203771] alloc_extent_buffer+0x11a/0x4b0 [btrfs]
[ 5258.203771] readahead_tree_block+0x18/0x50 [btrfs]
[ 5258.203771] read_block_for_search.isra.31+0x248/0x2f0 [btrfs]
[ 5258.203771] btrfs_search_slot+0x3c2/0x970 [btrfs]
[ 5258.203771] btrfs_lookup_csum+0x43/0x130 [btrfs]
[ 5258.203771] __btrfs_lookup_bio_sums+0x1fd/0x500 [btrfs]
[ 5258.203771] btrfs_lookup_bio_sums+0x16/0x20 [btrfs]
[ 5258.203771] btrfs_submit_bio_hook+0xb9/0x1a0 [btrfs]
[ 5258.203771] submit_one_bio+0x6c/0xa0 [btrfs]
[ 5258.203771] submit_extent_page.isra.48+0xe5/0x230 [btrfs]
[ 5258.203771] __do_readpage+0x294/0x910 [btrfs]
[ 5258.203771] ? btrfs_create_repair_bio+0xe0/0xe0 [btrfs]
[ 5258.203771] ? btrfs_submit_direct+0x880/0x880 [btrfs]
[ 5258.203771] __extent_readpages.constprop.52+0x302/0x370 [btrfs]
[ 5258.203771] ? btrfs_submit_direct+0x880/0x880 [btrfs]
[ 5258.203771] extent_readpages+0x17c/0x240 [btrfs]
[ 5258.203771] ? btrfs_submit_direct+0x880/0x880 [btrfs]
[ 5258.203771] btrfs_readpages+0x1f/0x30 [btrfs]
[ 5258.203771] __do_page_cache_readahead+0x292/0x380
[ 5258.203771] ? __do_page_cache_readahead+0x17c/0x380
[ 5258.203771] filemap_fault+0x4c5/0x840
[ 5258.203771] ? radix_tree_next_chunk+0x100/0x2a0
[ 5258.203771] ? filemap_map_pages+0x25b/0x4c0
[ 5258.203771] ? filemap_map_pages+0x5/0x4c0
[ 5258.203771] __do_fault+0x21/0x80
[ 5258.203771] handle_mm_fault+0xdb8/0x1200
[ 5258.203771] __do_page_fault+0x1fa/0x570
[ 5258.203771] do_page_fault+0x30/0x80
[ 5258.203771] page_fault+0x28/0x30
[ 5258.203771] RIP: 0033:0x4ab4e4
[ 5258.203771] RSP: 002b:00007ffdec8fd520 EFLAGS: 00010246
[ 5258.203771] RAX: 0000000001b158c0 RBX: 00000000015db010 RCX: 0000000001a9a7a8
[ 5258.203771] RDX: 0000000000000008 RSI: 0000000001a9a7a8 RDI: 0000000001b158c0
[ 5258.203771] RBP: 0000000001b2c5b0 R08: 0000000001b2f3b8 R09: 000000000191bba0
[ 5258.203771] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000001763e30
[ 5258.203771] R13: 0000000001763e30 R14: 00000000015e0f90 R15: 0000000000000001