xfstests generic/475 hit below kernel warning on upstream mainline kernel 5.5-rc4(HEAD: fd6988496e79 Linux 5.5-rc4) [94055.987303] XFS (dm-6): xfs_do_force_shutdown(0x2) called from line 1297 of file fs/xfs/xfs_log.c. Return address = ffffffffc0f84e7d [94055.987308] XFS (dm-6): Log I/O Error Detected. Shutting down filesystem [94055.987312] XFS (dm-6): Please unmount the filesystem and rectify the problem(s) [94056.027156] WARNING: CPU: 4 PID: 32186 at fs/iomap/buffered-io.c:1067 iomap_page_mkwrite_actor+0xd9/0x130 [94056.037835] Modules linked in: loop rfkill sunrpc intel_rapl_msr intel_rapl_common iTCO_wdt iTCO_vendor_support sb_edac x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm irqbypa ss crct10dif_pclmul crc32_pclmul ghash_clmulni_intel intel_cstate intel_uncore ipmi_ssif cdc_ether usbnet mii intel_rapl_perf sg ipmi_si pcspkr ipmi_devintf ioatdma ipmi_msghandler i2c_i801 l pc_ich ip_tables xfs libcrc32c wmi sd_mod mgag200 drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops drm_vram_helper drm_ttm_helper ttm drm igb dca crc32c_intel megaraid_sas i2c_alg o_bit dm_mirror dm_region_hash dm_log dm_mod [94056.097924] CPU: 4 PID: 32186 Comm: fsstress Tainted: G W 5.5.0-rc4-mainline #13 [94056.107642] Hardware name: IBM System x3650 M4 -[7915ON3]-/00J6520, BIOS -[VVE124AUS-1.30]- 11/21/2012 [94056.118044] RIP: 0010:iomap_page_mkwrite_actor+0xd9/0x130 [94056.124064] Code: 0f 44 e5 4c 89 e7 e8 d6 2a da ff 4c 89 e2 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 80 3c 02 00 75 53 49 8b 04 24 a8 04 75 23 <0f> 0b 48 89 ee 4c 89 ef e8 ca fb ff ff 48 89 ef e8 72 29 c1 ff 48 [94056.145020] RSP: 0000:ffff88843c937910 EFLAGS: 00010246 [94056.150852] RAX: 0017ffffc0000011 RBX: 0000000000001000 RCX: ffffffffa6b31fba [94056.158817] RDX: 1ffffd4000cfa008 RSI: 0000000000000008 RDI: ffffea00067d0040 [94056.166781] RBP: ffffea00067d0040 R08: fffff94000cfa009 R09: fffff94000cfa009 [94056.174744] R10: fffff94000cfa008 R11: ffffea00067d0047 R12: ffffea00067d0040 [94056.182707] R13: ffff8881947d2298 R14: ffff8881947d2298 R15: ffffffffc10acd20 [94056.190671] FS: 00007f3d4f6dfb80(0000) GS:ffff8881e7800000(0000) knlGS:0000000000000000 [94056.199700] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [94056.206112] CR2: 00007f3d4f6d1010 CR3: 0000000430596001 CR4: 00000000000606e0 [94056.214074] Call Trace: [94056.216810] iomap_apply+0x25d/0xb24 [94056.220800] ? iomap_page_create+0x350/0x350 [94056.225675] ? xfs_trans_alloc+0x468/0x660 [xfs] [94056.230830] ? trace_event_raw_event_iomap_page_class+0x3d0/0x3d0 [94056.237696] ? xfs_vn_fiemap+0xa0/0xa0 [xfs] [94056.242469] ? file_update_time+0x278/0x400 [94056.247140] ? iomap_page_create+0x350/0x350 [94056.251905] iomap_page_mkwrite+0x1f6/0x2e0 [94056.256575] ? iomap_page_create+0x350/0x350 [94056.261397] ? __xfs_filemap_fault+0x3db/0x700 [xfs] [94056.267005] __xfs_filemap_fault+0x495/0x700 [xfs] [94056.272359] ? lock_downgrade+0x6d0/0x6d0 [94056.276900] ? xfs_file_read_iter+0x740/0x740 [xfs] [94056.282353] do_page_mkwrite+0x18a/0x3b0 [94056.286733] do_wp_page+0xb2e/0x10b0 [94056.290724] ? do_raw_spin_trylock+0xb2/0x180 [94056.295587] ? finish_mkwrite_fault+0x610/0x610 [94056.300646] ? pgd_free+0x270/0x270 [94056.304544] __handle_mm_fault+0x1c38/0x3230 [94056.309313] ? lockdep_hardirqs_on+0x590/0x590 [94056.314272] ? lock_downgrade+0x6d0/0x6d0 [94056.318749] ? copy_page_range+0x6f0/0x6f0 [94056.323323] ? lock_acquire+0x15a/0x3d0 [94056.327611] ? down_read_non_owner+0x490/0x490 [94056.332573] handle_mm_fault+0x275/0x6f0 [94056.336957] __do_page_fault+0x3db/0xa50 [94056.341339] do_page_fault+0x37/0x550 [94056.345432] page_fault+0x3e/0x50 [94056.349133] RIP: 0033:0x7f3d4eb7ec3a [94056.353122] Code: 77 16 f3 0f 7f 07 f3 0f 7f 47 10 f3 0f 7f 44 17 f0 f3 0f 7f 44 17 e0 c3 48 8d 4f 40 f3 0f 7f 07 48 83 e1 c0 f3 0f 7f 44 17 f0 <f3> 0f 7f 47 10 f3 0f 7f 44 17 e0 f3 0f 7f 47 20 f3 0f 7f 44 17 d0 [94056.374077] RSP: 002b:00007ffe7c5c2f48 EFLAGS: 00010202 [94056.379909] RAX: 00007f3d4f6d1000 RBX: 0000000000055000 RCX: 00007f3d4f6d1040 [94056.387872] RDX: 000000000000db34 RSI: 000000000000004d RDI: 00007f3d4f6d1000 [94056.395835] RBP: 000000000007a120 R08: 0000000000000003 R09: 0000000000055000 [94056.403797] R10: 0000000000000008 R11: 0000000000000246 R12: 0000000051eb851f [94056.411762] R13: 000000000040c5e0 R14: 000000000000db34 R15: 0000000000000000 [94056.419734] irq event stamp: 0 [94056.423140] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [94056.430138] hardirqs last disabled at (0): [<ffffffffa61e05a4>] copy_process+0x1994/0x6430 [94056.439363] softirqs last enabled at (0): [<ffffffffa61e0640>] copy_process+0x1a30/0x6430 [94056.448587] softirqs last disabled at (0): [<0000000000000000>] 0x0 [94056.455581] ---[ end trace b6fdae90624bb004 ]--- [94056.682146] XFS (dm-6): Unmounting Filesystem # cat results/generic/475.full meta-data=/dev/mapper/rhel_ibm--x3650m4--10-xfscratch isize=512 agcount=4, agsize=5570560 blks = sectsz=512 attr=2, projid32bit=1 = crc=1 finobt=1, sparse=1, rmapbt=0 = reflink=1 data = bsize=4096 blocks=22282240, imaxpct=25 = sunit=0 swidth=0 blks naming =version 2 bsize=4096 ascii-ci=0, ftype=1 log =internal log bsize=4096 blocks=10880, version=2 = sectsz=512 sunit=0 blks, lazy-count=1 realtime =none extsz=4096 blocks=0, rtextents=0 device-mapper: remove ioctl on error-test failed: No such device or address Command failed. seed = 1577643598 seed = 1578055977 seed = 1577955642 seed = 1577419009 ... ... This can be reproduced by loop running generic/475 on xfs.
Looks like a race between the log write failure shutting down the fs, and another thread running through the page_mkwrite code path. Not sure how to fix this since the disk is gone (hence !Pageuptodate) but iomap has no way to know that the caller fs is already dead anyway.