[Bug 216564] New: [xfstests xfs/013] WARNING: CPU: 4 PID: 3240987 at fs/dax.c:380 dax_insert_entry+0x6b8/0xa70

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



https://bugzilla.kernel.org/show_bug.cgi?id=216564

            Bug ID: 216564
           Summary: [xfstests xfs/013] WARNING: CPU: 4 PID: 3240987 at
                    fs/dax.c:380 dax_insert_entry+0x6b8/0xa70
           Product: File System
           Version: 2.5
    Kernel Version: v6.1-rc0
          Hardware: All
                OS: Linux
              Tree: Mainline
            Status: NEW
          Severity: normal
          Priority: P1
         Component: XFS
          Assignee: filesystem_xfs@xxxxxxxxxxxxxxxxxxxxxx
          Reporter: zlang@xxxxxxxxxx
        Regression: No

I hit below kernel warning on xfs (on pmem) with:
MOUNT_OPTIONS="-o dax=always".
MKFS_OPTIONS="-b size=4096 -d su=2m,sw=1 -m
crc=1,finobt=1,rmapbt=0,reflink=0,inobtcount=1,bigtime=1"

And besides xfs/013, others cases likes xfs/104, xfs/168 and xfs/538 triggered
this warning too.

[16212.233693] run fstests xfs/013 at 2022-10-08 15:17:59
[16220.298671] XFS (pmem0): DAX enabled. Warning: EXPERIMENTAL, use at your own
risk
[16220.307421] XFS (pmem0): Mounting V5 Filesystem
[16220.328753] XFS (pmem0): Ending clean mount
[16220.353113] XFS (pmem0): Unmounting Filesystem
[16220.979982] XFS (pmem0): DAX enabled. Warning: EXPERIMENTAL, use at your own
risk
[16220.988705] XFS (pmem0): Mounting V5 Filesystem
[16221.010026] XFS (pmem0): Ending clean mount
[17212.927302] ------------[ cut here ]------------
[17212.932779] WARNING: CPU: 4 PID: 3240987 at fs/dax.c:380
dax_insert_entry+0x6b8/0xa70
[17212.940623] Modules linked in: overlay dm_log_writes ext4 mbcache jbd2 loop
rfkill sunrpc intel_rapl_msr intel_rapl_common intel_uncore_frequency mgag200
intel_uncore_frequency_common ipmi_ssif i2c_algo_bit mlx5_ib drm_shmem_helper
i10nm_edac drm_kms_helper nfit syscopyarea x86_pkg_temp_thermal
intel_powerclamp coretemp kvm_intel dcdbas kvm irqbypass dell_smbios rapl
intel_cstate ib_uverbs intel_uncore nd_pmem dax_pmem pcspkr dell_wmi_descriptor
wmi_bmof mei_me isst_if_mmio ib_core isst_if_mbox_pci sysfillrect acpi_ipmi
isst_if_common i2c_i801 sysimgblt fb_sys_fops i2c_smbus mei ipmi_si
intel_pch_thermal intel_vsec ipmi_devintf ipmi_msghandler acpi_power_meter drm
fuse xfs libcrc32c sd_mod t10_pi sg mlx5_core crct10dif_pclmul crc32_pclmul
crc32c_intel mlxfw ghash_clmulni_intel ahci tls libahci psample megaraid_sas
pci_hyperv_intf tg3 libata wmi dm_mirror dm_region_hash dm_log dm_mod [last
unloaded: scsi_debug]
[17213.021327] CPU: 4 PID: 3240987 Comm: fsstress Kdump: loaded Tainted: G     
  W          6.0.0+ #1
[17213.030374] Hardware name: Dell Inc. PowerEdge R750/0PJ80M, BIOS 1.5.4
12/17/2021
[17213.037852] RIP: 0010:dax_insert_entry+0x6b8/0xa70
[17213.042655] Code: 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc 48 c1 ee 03 42
80 3c 26 00 0f 85 18 03 00 00 48 8b 7b 20 48 8d 6f 01 e9 9b fe ff ff <0f> 0b e9
e3 fe ff ff 31 f6 4c 89 ef 44 89 04 24 e8 c3 a2 62 00 44
[17213.061409] RSP: 0000:ffa000002a4f7818 EFLAGS: 00010086
[17213.066644] RAX: ffd4000004060d40 RBX: ffd4000004060d00 RCX:
0000000000000000
[17213.073783] RDX: 0000000000000290 RSI: ff110011667bc448 RDI:
ff1100096a1e7008
[17213.080917] RBP: ffd4000004060d18 R08: 0000000000000000 R09:
ffffffff98787fc7
[17213.088049] R10: fffffbfff30f0ff8 R11: 0000000000000001 R12:
dffffc0000000000
[17213.095182] R13: ffa000002a4f7a58 R14: ff11001143a5fc48 R15:
0000000000000008
[17213.102316] FS:  00007fb39b93b740(0000) GS:ff11000cd9600000(0000)
knlGS:0000000000000000
[17213.110410] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[17213.116154] CR2: 00007fb39b935000 CR3: 0000000a4a274005 CR4:
0000000000771ee0
[17213.123288] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
0000000000000000
[17213.130420] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7:
0000000000000400
[17213.137553] PKRU: 55555554
[17213.140267] Call Trace:
[17213.142720]  <TASK>
[17213.144835]  ? dax_read_unlock+0xd/0x40
[17213.148687]  ? __dax_invalidate_entry+0x1f0/0x1f0
[17213.153402]  ? dax_read_unlock+0x20/0x40
[17213.157334]  ? dax_iomap_direct_access+0x14d/0x1d0
[17213.162143]  dax_fault_iter+0x29d/0x6d0
[17213.166002]  ? dax_pmd_load_hole+0xa50/0xa50
[17213.170289]  ? iomap_iter+0x83b/0xdc0
[17213.173978]  dax_iomap_pte_fault+0x3ec/0xa40
[17213.178264]  ? dax_fault_iter+0x6d0/0x6d0
[17213.182299]  ? lock_acquire+0x1d8/0x620
[17213.186186]  ? xfs_ilock+0x162/0x4d0 [xfs]
[17213.190442]  ? xfs_ilock+0x162/0x4d0 [xfs]
[17213.194691]  __xfs_filemap_fault+0x612/0x8f0 [xfs]
[17213.199621]  ? xfs_file_fsync+0xae0/0xae0 [xfs]
[17213.204299]  __do_fault+0xf5/0x440
[17213.207717]  do_fault+0x427/0x710
[17213.211047]  __handle_mm_fault+0xa15/0xe60
[17213.215171]  ? vm_iomap_memory+0x150/0x150
[17213.219271]  ? __lock_release+0x4c1/0xa00
[17213.223311]  ? count_memcg_event_mm.part.0+0xbd/0x1d0
[17213.228381]  handle_mm_fault+0x16b/0x5e0
[17213.232325]  do_user_addr_fault+0x343/0xdd0
[17213.236523]  ? rcu_read_lock_sched_held+0x43/0x80
[17213.241241]  exc_page_fault+0x5a/0xe0
[17213.244920]  asm_exc_page_fault+0x22/0x30
[17213.248939] RIP: 0033:0x7fb39b6cb17a
[17213.252527] Code: 00 00 b9 ff ff ff ff c4 e2 68 f5 c9 c5 fb 92 c9 62 e1 7f
29 7f 00 c3 66 0f 1f 84 00 00 00 00 00 40 0f b6 c6 48 89 d1 48 89 fa <f3> aa 48
89 d0 c3 48 3b 15 51 f2 12 00 77 e7 62 e1 fe 28 7f 07 62
[17213.271279] RSP: 002b:00007fff0a1fbee8 EFLAGS: 00010206
[17213.276516] RAX: 0000000000000056 RBX: 0000000000289000 RCX:
0000000000005524
[17213.283647] RDX: 00007fb39b92e000 RSI: 0000000000000056 RDI:
00007fb39b935000
[17213.290781] RBP: 028f5c28f5c28f5c R08: 0000000000000000 R09:
0000000000289000
[17213.297913] R10: 0000000000000008 R11: 0000000000000246 R12:
000000000000c524
[17213.305045] R13: 8f5c28f5c28f5c29 R14: 000000000040cff0 R15:
00007fb39b93b6c0
[17213.312205]  </TASK>
[17213.314397] irq event stamp: 9780986
[17213.317975] hardirqs last  enabled at (9780985): [<ffffffff93a205f9>]
kasan_quarantine_put+0x109/0x220
[17213.327284] hardirqs last disabled at (9780986): [<ffffffff954adafe>]
_raw_spin_lock_irq+0x5e/0x90
[17213.336245] softirqs last  enabled at (9776938): [<ffffffff95800625>]
__do_softirq+0x625/0x9b0
[17213.344859] softirqs last disabled at (9776931): [<ffffffff9322640c>]
__irq_exit_rcu+0x1fc/0x2a0
[17213.353648] ---[ end trace 0000000000000000 ]---
[17636.123091] ------------[ cut here ]------------
[17636.128588] WARNING: CPU: 14 PID: 3240987 at fs/dax.c:404
dax_disassociate_entry+0x82/0x2c0
[17636.136952] Modules linked in: overlay dm_log_writes ext4 mbcache jbd2 loop
rfkill sunrpc intel_rapl_msr intel_rapl_common intel_uncore_frequency mgag200
intel_uncore_frequency_common ipmi_ssif i2c_algo_bit mlx5_ib drm_shmem_helper
i10nm_edac drm_kms_helper nfit syscopyarea x86_pkg_temp_thermal
intel_powerclamp coretemp kvm_intel dcdbas kvm irqbypass dell_smbios rapl
intel_cstate ib_uverbs intel_uncore nd_pmem dax_pmem pcspkr dell_wmi_descriptor
wmi_bmof mei_me isst_if_mmio ib_core isst_if_mbox_pci sysfillrect acpi_ipmi
isst_if_common i2c_i801 sysimgblt fb_sys_fops i2c_smbus mei ipmi_si
intel_pch_thermal intel_vsec ipmi_devintf ipmi_msghandler acpi_power_meter drm
fuse xfs libcrc32c sd_mod t10_pi sg mlx5_core crct10dif_pclmul crc32_pclmul
crc32c_intel mlxfw ghash_clmulni_intel ahci tls libahci psample megaraid_sas
pci_hyperv_intf tg3 libata wmi dm_mirror dm_region_hash dm_log dm_mod [last
unloaded: scsi_debug]
[17636.217656] CPU: 14 PID: 3240987 Comm: fsstress Kdump: loaded Tainted: G    
   W          6.0.0+ #1
[17636.226791] Hardware name: Dell Inc. PowerEdge R750/0PJ80M, BIOS 1.5.4
12/17/2021
[17636.234277] RIP: 0010:dax_disassociate_entry+0x82/0x2c0
[17636.239513] Code: c1 e8 03 42 80 3c 20 00 0f 85 c3 01 00 00 48 8b 43 18 4c
8d 53 20 48 83 f8 01 0f 84 ec 00 00 00 48 39 c8 74 07 48 85 c0 74 02 <0f> 0b 4c
89 c8 48 c1 e8 03 42 80 3c 20 00 0f 85 61 01 00 00 4c 89
[17636.258268] RSP: 0018:ffa000002a4f7780 EFLAGS: 00010086
[17636.263500] RAX: ff1100060b511448 RBX: ffd40000091176c0 RCX:
ff11001144b58448
[17636.270634] RDX: 0000000000000001 RSI: 0000000000000000 RDI:
ffd40000091176f4
[17636.277765] RBP: 00000000002445db R08: 0000000000000000 R09:
ffd40000091176d8
[17636.284900] R10: ffd40000091176e0 R11: 0000000000000001 R12:
dffffc0000000000
[17636.292030] R13: ffd40000091176f4 R14: 00000000002445db R15:
fffffbfff2c5c28a
[17636.299165] FS:  00007fb39b93b740(0000) GS:ff11000cdaa00000(0000)
knlGS:0000000000000000
[17636.307251] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[17636.313005] CR2: 00007fb39b93a000 CR3: 0000000a4a274005 CR4:
0000000000771ee0
[17636.320138] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
0000000000000000
[17636.327269] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7:
0000000000000400
[17636.334402] PKRU: 55555554
[17636.337117] Call Trace:
[17636.339568]  <TASK>
[17636.341691]  __dax_invalidate_entry+0xe1/0x1f0
[17636.346150]  ? dax_layout_busy_page+0x20/0x20
[17636.350533]  ? find_lock_entries+0x508/0x940
[17636.354821]  dax_delete_mapping_entry+0xf/0x20
[17636.359278]  truncate_folio_batch_exceptionals.part.0+0x400/0x510
[17636.365391]  ? clear_shadow_entry+0x210/0x210
[17636.369783]  truncate_inode_pages_range+0x1a8/0xe10
[17636.374681]  ? truncate_inode_partial_folio+0x890/0x890
[17636.379931]  ? unmap_mapping_range+0xe0/0x250
[17636.384323]  ? xfs_bmap_collapse_extents+0x650/0x650 [xfs]
[17636.389964]  xfs_flush_unmap_range+0xca/0x110 [xfs]
[17636.394981]  xfs_prepare_shift+0x103/0x210 [xfs]
[17636.399738]  xfs_insert_file_space+0x30e/0x5e0 [xfs]
[17636.404836]  ? xfs_collapse_file_space+0x570/0x570 [xfs]
[17636.410274]  ? xfs_vn_getattr+0x12f0/0x1320 [xfs]
[17636.415117]  ? setattr_prepare+0xe6/0x9e0
[17636.419156]  xfs_file_fallocate+0x5c0/0xdd0 [xfs]
[17636.424002]  ? xfs_break_layouts+0x130/0x130 [xfs]
[17636.428925]  ? rcu_read_unlock+0x40/0x40
[17636.432886]  vfs_fallocate+0x2aa/0xbb0
[17636.436654]  __x64_sys_fallocate+0xb4/0x100
[17636.440853]  do_syscall_64+0x59/0x90
[17636.444439]  ? do_syscall_64+0x69/0x90
[17636.448196]  ? lockdep_hardirqs_on+0x79/0x100
[17636.452568]  ? do_syscall_64+0x69/0x90
[17636.456327]  ? do_syscall_64+0x69/0x90
[17636.460078]  ? do_syscall_64+0x69/0x90
[17636.463832]  ? asm_exc_page_fault+0x22/0x30
[17636.468027]  ? lockdep_hardirqs_on+0x79/0x100
[17636.472398]  entry_SYSCALL_64_after_hwframe+0x63/0xcd
[17636.477455] RIP: 0033:0x7fb39b7432ca
[17636.481043] Code: d8 64 89 02 b8 ff ff ff ff eb bd 0f 1f 44 00 00 f3 0f 1e
fa 49 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 15 b8 1d 01 00 00 0f 05 <48> 3d 00
f0 ff ff 77 5e c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[17636.499790] RSP: 002b:00007fff0a1fbfb8 EFLAGS: 00000246 ORIG_RAX:
000000000000011d
[17636.507364] RAX: ffffffffffffffda RBX: 0000000000000020 RCX:
00007fb39b7432ca
[17636.514498] RDX: 0000000000039000 RSI: 0000000000000020 RDI:
0000000000000003
[17636.521636] RBP: 0000000000000003 R08: 0000000000000068 R09:
00007fff0a1fbfdc
[17636.528771] R10: 0000000000063000 R11: 0000000000000246 R12:
0000000000017c23
[17636.535904] R13: 0000000000063000 R14: 0000000000000000 R15:
0000000000039000
[17636.543062]  </TASK>
[17636.545254] irq event stamp: 66760960
[17636.548920] hardirqs last  enabled at (66760959): [<ffffffff954addf4>]
_raw_spin_unlock_irq+0x24/0x50
[17636.558140] hardirqs last disabled at (66760960): [<ffffffff954adafe>]
_raw_spin_lock_irq+0x5e/0x90
[17636.567182] softirqs last  enabled at (66760216): [<ffffffff95800625>]
__do_softirq+0x625/0x9b0
[17636.575884] softirqs last disabled at (66760209): [<ffffffff9322640c>]
__irq_exit_rcu+0x1fc/0x2a0
[17636.584756] ---[ end trace 0000000000000000 ]---
[18289.471495] XFS (pmem0): Unmounting Filesystem
[18291.618034] XFS (pmem1): Unmounting Filesystem

-- 
You may reply to this email to add a comment.

You are receiving this mail because:
You are watching the assignee of the bug.



[Index of Archives]     [XFS Filesystem Development (older mail)]     [Linux Filesystem Development]     [Linux Audio Users]     [Yosemite Trails]     [Linux Kernel]     [Linux RAID]     [Linux SCSI]


  Powered by Linux