402 Star 1.4K Fork 1.3K

GVPopenEuler / kernel

 / 详情

【OLK同步】 WARNING in ext4_iomap_overwrite_begin

已完成
任务
创建于  
2023-05-06 10:46
cmd=cd fs_fusiontest/tests/test_fs_fusion087; sh test.sh   testing... 3765
delete /dev/sdc
stress-ng
[ 4417.239419][  T150] print_req_error: 26 callbacks suppressed
[ 4417.239439][  T150] blk_update_request: I/O error, dev sdc, sector 142674720 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.248930][  T150] buffer_io_error: 15 callbacks suppressed
[ 4417.248961][  T150] Buffer I/O error on dev sdc, logical block 17834340, lost async page write
[ 4417.266334][  T150] blk_update_request: I/O error, dev sdc, sector 142674736 op 0x1:(WRITE) flags 0x3800 phys_seg 2 prio class 0
[ 4417.272060][  T150] Buffer I/O error on dev sdc, logical block 17834342, lost async page write
[ 4417.277252][  T150] Buffer I/O error on dev sdc, logical block 17834343, lost async page write
[ 4417.281780][T90820] EXT4-fs error (device sdc): ext4_check_bdev_write_error:217: comm fsstress: Error while async write back metadata
[ 4417.283197][  T150] blk_update_request: I/O error, dev sdc, sector 142674800 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.294764][T90820] EXT4-fs error (device sdc): ext4_check_bdev_write_error:217: comm fsstress: Error while async write back metadata
[ 4417.298404][  T150] Buffer I/O error on dev sdc, logical block 17834350, lost async page write
[ 4417.298672][  T150] blk_update_request: I/O error, dev sdc, sector 142674816 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.298683][  T150] Buffer I/O error on dev sdc, logical block 17834352, lost async page write
[ 4417.298878][  T150] blk_update_request: I/O error, dev sdc, sector 142674872 op 0x1:(WRITE) flags 0x3800 phys_seg 3 prio class 0
[ 4417.298891][  T150] Buffer I/O error on dev sdc, logical block 17834359, lost async page write
[ 4417.298927][  T150] Buffer I/O error on dev sdc, logical block 17834360, lost async page write
[ 4417.298964][  T150] Buffer I/O error on dev sdc, logical block 17834361, lost async page write
[ 4417.299137][  T150] blk_update_request: I/O error, dev sdc, sector 142674912 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.299151][  T150] Buffer I/O error on dev sdc, logical block 17834364, lost async page write
[ 4417.299329][  T150] blk_update_request: I/O error, dev sdc, sector 142674936 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.299344][  T150] Buffer I/O error on dev sdc, logical block 17834367, lost async page write
[ 4417.299595][  T150] blk_update_request: I/O error, dev sdc, sector 142674976 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.391109][  T150] blk_update_request: I/O error, dev sdc, sector 142674992 op 0x1:(WRITE) flags 0x3800 phys_seg 1 prio class 0
[ 4417.399730][  T150] blk_update_request: I/O error, dev sdc, sector 142675080 op 0x1:(WRITE) flags 0x3800 phys_seg 3 prio class 0
[ 4417.409514][T90820] EXT4-fs error (device sdc): ext4_check_bdev_write_error:217: comm fsstress: Error while async write back metadata
[ 4417.419826][    T8] EXT4-fs warning (device sdc): ext4_end_bio:347: I/O error 10 writing to inode 4457390 starting block 17834384)
[ 4417.429880][    T8] buffer_io_error: 101 callbacks suppressed
[ 4417.429892][    T8] Buffer I/O error on device sdc, logical block 17834383
[ 4417.444695][T70356] EXT4-fs warning (device sdc): ext4_end_bio:347: I/O error 10 writing to inode 4457369 starting block 197674)
[ 4417.453892][T70356] EXT4-fs error (device sdc): ext4_check_bdev_write_error:217: comm kworker/u8:2: Error while async write back metadata
[ 4417.457205][T90818] EXT4-fs error (device sdc): ext4_check_bdev_write_error:217: comm fsstress: Error while async write back metadata
[ 4417.463960][T70356] Buffer I/O error on device sdc, logical block 197671
[ 4417.477115][T70356] Buffer I/O error on device sdc, logical block 197672
[ 4417.482352][T70356] Buffer I/O error on device sdc, logical block 197673
[ 4417.491326][T90821] EXT4-fs warning (device sdc): ext4_end_bio:347: I/O error 10 writing to inode 4457383 starting block 196908)
[ 4417.507831][T70356] Buffer I/O error on device sdc, logical block 196904
[ 4417.512780][T70356] Buffer I/O error on device sdc, logical block 196905
[ 4417.517634][T70356] Buffer I/O error on device sdc, logical block 196906
[ 4417.522588][T70356] Buffer I/O error on device sdc, logical block 196907
[ 4417.525562][  T123] EXT4-fs warning (device sdc): ext4_end_bio:347: I/O error 10 writing to inode 4457369 starting block 197683)
[ 4417.536966][  T123] EXT4-fs warning (device sdc): ext4_end_bio:347: I/O error 10 writing to inode 4457383 starting block 201236)
[ 4417.544821][T70356] Buffer I/O error on device sdc, logical block 197674
[ 4417.549887][T70356] Buffer I/O error on device sdc, logical block 197675
[ 4417.562329][T89856] JBD2: Detected IO errors while flushing file data on sdc-8
[ 4417.568150][T89856] Aborting journal on device sdc-8.
[ 4417.571787][T85977] EXT4-fs (sdc): ext4_writepages: jbd2_start: 9223372036854775807 pages, ino 4457331; err -30
[ 4417.571820][T90821] EXT4-fs error (device sdc): ext4_journal_check_start:83: comm fsstress: Detected aborted journal
[ 4417.575915][T89856] JBD2: Error -5 detected when updating journal superblock for sdc-8.
[ 4417.578718][T85977] EXT4-fs error (device sdc): ext4_journal_check_start:83: comm kworker/u8:0: Detected aborted journal
[ 4417.587037][T90818] EXT4-fs error (device sdc): ext4_journal_check_start:83: comm fsstress: Detected aborted journal
[ 4417.591340][T85977] EXT4-fs (sdc): previous I/O error to superblock detected
[ 4417.600036][T90820] EXT4-fs error (device sdc): ext4_journal_check_start:83: comm fsstress: Detected aborted journal
[ 4417.605823][T85977] EXT4-fs (sdc): I/O error while writing superblock
[ 4417.609570][T90818] EXT4-fs (sdc): previous I/O error to superblock detected
[ 4417.609766][T90818] EXT4-fs (sdc): I/O error while writing superblock
[ 4417.609773][T90818] EXT4-fs (sdc): Remounting filesystem read-only
[ 4417.631696][T85977] EXT4-fs (sdc): ext4_writepages: jbd2_start: 9223372036854775807 pages, ino 4457340; err -30
[ 4417.696454][T90848] sh (90848): drop_caches: 3
[ 4417.703174][T90818] EXT4-fs error (device sdc): __ext4_find_entry:1585: inode #4456455: comm fsstress: reading directory lblock 0
[ 4417.713272][T76705] EXT4-fs (sdc): I/O error while writing superblock
[ 4417.717007][T90850] sh (90850): drop_caches: 3
[ 4417.732912][T90820] ------------[ cut here ]------------
[ 4417.736889][T90820] WARNING: CPU: 3 PID: 90820 at fs/ext4/inode.c:3503 ext4_iomap_overwrite_begin+0x94/0xa0
[ 4417.737931][T85774] EXT4-fs (sdc): I/O error while writing superblock
[ 4417.743440][T90820] Modules linked in:
[ 4417.748407][T85774] EXT4-fs (sdc): I/O error while writing superblock
[ 4417.750468][T90820] CPU: 3 PID: 90820 Comm: fsstress Not tainted 5.10.0-00468-g646bcb923d89 #28
[ 4417.761254][T90820] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
[ 4417.769794][T90820] RIP: 0010:ext4_iomap_overwrite_begin+0x94/0xa0
[ 4417.774141][T90820] Code: 00 89 de e8 de e8 64 ff 66 83 fb 02 75 17 e8 c3 f1 64 ff 44 89 e0 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc e8 ac f1 64 ff <0f> 0b eb e0 e8 63 bc bc ff eb c3 90 0f 1f 44 00 00 41 57 41 56 49
[ 4417.778392][  T873] sd 2:0:1:0: [sdc] Synchronizing SCSI cache
[ 4417.794451][T90820] RSP: 0018:ffff8881455175a0 EFLAGS: 00010293
[ 4417.803215][T90820] RAX: 0000000000000000 RBX: 0000000000000000 RCX: ffffffff820aa462
[ 4417.808879][T90820] RDX: ffff888124a94040 RSI: ffffffff820aa484 RDI: 0000000000000003
[ 4417.814590][T90820] RBP: 0000000000000011 R08: 0000000000000001 R09: ffff8881284bb9b7
[ 4417.820173][T90820] R10: 0000000000000002 R11: 0000000000000001 R12: 00000000fffffffb
[ 4417.825830][T90820] R13: 0000000000059000 R14: 0000000000003000 R15: ffff888145517690
[ 4417.831552][T90820] FS:  00007fcc931ec740(0000) GS:ffff8881f6b80000(0000) knlGS:0000000000000000
[ 4417.837809][T90820] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 4417.842593][T90820] CR2: 000056440440c948 CR3: 00000001600d4001 CR4: 0000000000770ee0
[ 4417.848249][T90820] PKRU: 55555554
[ 4417.850729][T90820] Call Trace:
[ 4417.853109][T90820]  iomap_apply+0x166/0xab0
[ 4417.855604][T90849] sh (90849): drop_caches: 3
[ 4417.856260][T90820]  ? iomap_dio_inline_actor+0x340/0x340
[ 4417.863392][T90820]  ? __bpf_trace_iomap_apply+0x210/0x210
[ 4417.867241][T90820]  ? mark_held_locks+0x9e/0xe0
[ 4417.870737][T90820]  ? filemap_check_errors+0xaa/0x160
[ 4417.874592][T90820]  __iomap_dio_rw+0x77e/0x11f0
[ 4417.878049][T90820]  ? iomap_dio_inline_actor+0x340/0x340
[ 4417.882269][T90820]  ? iomap_dio_actor+0x250/0x250
[ 4417.885934][T90820]  ? ext4_dax_fault+0x20/0x20
[ 4417.889361][T90820]  iomap_dio_rw+0x36/0x90
[ 4417.892440][T90820]  ext4_dio_write_iter+0x978/0xc90
[ 4417.896117][T90820]  ? ext4_buffered_write_iter+0x4d0/0x4d0
[ 4417.900114][T90820]  ? ovl_write_iter+0x6d0/0x1940
[ 4417.903644][T90820]  ? __lock_release+0x21/0x520
[ 4417.907068][T90820]  ? lock_downgrade+0x100/0x100
[ 4417.910537][T90820]  ? security_file_permission+0x272/0x580
[ 4417.914698][T90820]  ext4_file_write_iter+0x1b7/0x230
[ 4417.918389][T90820]  vfs_iocb_iter_write+0x1bd/0x410
[ 4417.919346][  T873] sd 2:0:1:0: [sdc] Stopping disk
[ 4417.922173][T90820]  ovl_write_iter+0x9fd/0x1940
[ 4417.928130][T90820]  ? ovl_splice_write+0xe10/0xe10
[ 4417.929081][T90821] scsi 2:0:1:0: rejecting I/O to dead device
[ 4417.931762][T90820]  aio_write+0x353/0x7d0
[ 4417.938811][T90820]  ? aio_poll_complete_work+0xe40/0xe40
[ 4417.942861][T90820]  ? __fget_files+0x272/0x500
[ 4417.946280][T90820]  ? __lock_release+0x102/0x520
[ 4417.949749][T90820]  ? lock_downgrade+0x100/0x100
[ 4417.953268][T90820]  ? __fget_files+0x272/0x500
[ 4417.956692][T90820]  ? __might_fault+0xd8/0x180
[ 4417.960064][T90820]  __io_submit_one.constprop.0+0x3b6/0x4e0
[ 4417.964390][T90820]  io_submit_one+0x30d/0xeb0
[ 4417.967797][T90820]  ? lock_downgrade+0x100/0x100
[ 4417.971212][T90820]  ? __io_submit_one.constprop.0+0x4e0/0x4e0
[ 4417.975446][T90820]  ? __might_fault+0xd8/0x180
[ 4417.978917][T90820]  __se_sys_io_submit+0x12f/0x590
[ 4417.982646][T90820]  ? io_submit_one+0xeb0/0xeb0
[ 4417.986071][T90820]  ? __audit_syscall_entry+0x3f9/0x550
[ 4417.990114][T90820]  do_syscall_64+0x30/0x40
[ 4417.993238][T90820]  entry_SYSCALL_64_after_hwframe+0x61/0xc6
[ 4417.997323][T90820] RIP: 0033:0x7fcc9281a91d
[ 4418.000577][T90820] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 3b 65 38 00 f7 d8 64 89 01 48
[ 4418.014282][T90820] RSP: 002b:00007ffe98c88ef8 EFLAGS: 00000246 ORIG_RAX: 00000000000000d1
[ 4418.020289][T90820] RAX: ffffffffffffffda RBX: 00007fcc931ec6c0 RCX: 00007fcc9281a91d
[ 4418.025737][T90820] RDX: 00007ffe98c88fc8 RSI: 0000000000000001 RDI: 00007fcc931f4000
[ 4418.031325][T90820] RBP: 00007fcc931f4000 R08: 0000000000000003 R09: 0000000000000003
[ 4418.036906][T90820] R10: 0000000000001000 R11: 0000000000000246 R12: 0000000000000001
[ 4418.042535][T90820] R13: 0000000000000019 R14: 00007ffe98c88fc8 R15: 0000000000059000
[ 4418.048328][T90820] irq event stamp: 136169
[ 4418.051393][T90820] hardirqs last  enabled at (136179): [<ffffffff8154f88f>] console_unlock+0x66f/0x790
[ 4418.058072][T90820] hardirqs last disabled at (136188): [<ffffffff8154f7ea>] console_unlock+0x5ca/0x790
cmd=cd fs_fusiontest/tests/test_fs_fusion087; sh test.sh   testing... 3766
[ 4418.064793][T90820] softirqs last  enabled at (135544): [<ffffffff85000558>] __do_softirq+0x558/0x906
[ 4418.072138][T90820] softirqs last disabled at (135487): [<ffffffff84e010ff>] asm_call_irq_on_stack+0xf/0x20
[ 4418.079291][T90820] ---[ end trace 63b8832f2632c324 ]---

评论 (2)

LiBaokun 创建了任务
openeuler-ci-bot 添加了
 
sig/Kernel
标签
do_syscall_64
 __se_sys_io_submit
  io_submit_one
   __io_submit_one
    aio_write
     ovl_write_iter
      vfs_iocb_iter_write
       ext4_file_write_iter
        ext4_dio_write_iter
         iomap_dio_rw
          __iomap_dio_rw
           iomap_apply
            ext4_iomap_overwrite_begin
             ext4_iomap_begin
              ext4_map_blocks
               ext4_ext_map_blocks  ---> drop_cache 使得 es status tree 被清除
                ext4_find_extent
                 kcalloc ---> nomem 场景二,内存分配失败,无打印,自发现
               check_block_validity
                __check_block_validity ---> illegal pblock 场景一,写裸盘,有打印,社区报告
                 return
             WARN_ON_ONCE(iomap->type != IOMAP_MAPPED)

ext4_iomap_overwrite_begin() 调用 ext4_iomap_begin() map 块时,可能会因为某些原因(比如内存分配失败,写裸盘)导致 map blocks 失败, 之后可能会因为 "iomap->type != IOMAP_MAPPED" 触发 WARN_ON(). 当 ext4_iomap_begin() 返回错误时,iomap->type 的类型不符合预期是正常的。因此我们只在 ext4_iomap_begin() 执行成功时判断 iomap->type 是否符合预期。

登录 后才可以发表评论

状态
负责人
项目
里程碑
Pull Requests
关联的 Pull Requests 被合并后可能会关闭此 issue
分支
开始日期   -   截止日期
-
置顶选项
优先级
预计工期 (小时)
参与者(2)
5329419 openeuler ci bot 1632792936
C
1
https://gitee.com/openeuler/kernel.git
git@gitee.com:openeuler/kernel.git
openeuler
kernel
kernel

搜索帮助