* WARNING: at fs/btrfs/free-space-cache.c:305
@ 2011-11-03 1:25 Tsutomu Itoh
2011-11-03 11:19 ` Chris Mason
2011-11-09 15:17 ` Josef Bacik
0 siblings, 2 replies; 8+ messages in thread
From: Tsutomu Itoh @ 2011-11-03 1:25 UTC (permalink / raw)
To: Linux Btrfs; +Cc: Chris Mason
In integration-scrub branch, following warning messages were displayed by
running xfstests.
# btrfs fi sh /dev/sdd4
Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
Total devices 2 FS bytes used 31.49MB
devid 1 size 9.31GB used 9.31GB path /dev/sdd4
devid 2 size 15.01GB used 9.29GB path /dev/sdc1
Btrfs Btrfs v0.19
# mount
...
/dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
#
Thanks,
Tsutomu
====================================================================================
Nov 3 09:55:18 luna kernel: [ 939.732044] device fsid 8f28d85c-e37c-4c1b-adef-2627ca59be78 devid 1 transid 20510 /dev/sdd4
Nov 3 09:55:18 luna kernel: [ 939.732533] btrfs: use lzo compression
Nov 3 09:55:18 luna kernel: [ 939.732536] btrfs: disk space caching is enabled
Nov 3 09:55:18 luna kernel: [ 939.898190] ------------[ cut here ]------------
Nov 3 09:55:18 luna kernel: [ 939.898223] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
Nov 3 09:55:18 luna kernel: [ 939.898227] Hardware name: PRIMERGY
Nov 3 09:55:18 luna kernel: [ 939.898229] Modules linked in: btrfs zlib_deflate crc32c libcrc32c nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
Nov 3 09:55:18 luna kernel: [ 939.898291] Pid: 13337, comm: dd Not tainted 3.1.0integ-sc+ #1
Nov 3 09:55:18 luna kernel: [ 939.898294] Call Trace:
Nov 3 09:55:18 luna kernel: [ 939.898303] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
Nov 3 09:55:18 luna kernel: [ 939.898308] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
Nov 3 09:55:18 luna kernel: [ 939.898328] [<ffffffffa0477507>] io_ctl_map_page+0x29/0x76 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898349] [<ffffffffa0477733>] io_ctl_check_crc+0x62/0xdd [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898369] [<ffffffffa0476051>] ? tree_insert_offset+0xa7/0xb2 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898389] [<ffffffffa047917f>] __load_free_space_cache+0x457/0x509 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898410] [<ffffffffa04793ca>] load_free_space_cache+0xca/0x168 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898427] [<ffffffffa043cd12>] cache_block_group+0xa3/0x1f2 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898443] [<ffffffffa043ec3d>] find_free_extent+0x478/0xa58 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898448] [<ffffffff81014e61>] ? sched_clock+0x9/0xd
Nov 3 09:55:18 luna kernel: [ 939.898454] [<ffffffff8106c28d>] ? sched_clock_local+0x1c/0x82
Nov 3 09:55:18 luna kernel: [ 939.898471] [<ffffffffa043f2d2>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898487] [<ffffffffa043f561>] btrfs_alloc_free_block+0x180/0x2a7 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898493] [<ffffffff813a7e1d>] ? __wait_on_bit+0x69/0x7b
Nov 3 09:55:18 luna kernel: [ 939.898507] [<ffffffffa0431446>] __btrfs_cow_block+0x121/0x3f3 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898522] [<ffffffffa0431c1b>] btrfs_cow_block+0x120/0x166 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898536] [<ffffffffa04339ee>] btrfs_search_slot+0x2ea/0x743 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898552] [<ffffffffa0437bae>] ? reserve_metadata_bytes+0xb8/0x599 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898557] [<ffffffff810d3b02>] ? filemap_fdatawait_range+0x120/0x16b
Nov 3 09:55:18 luna kernel: [ 939.898572] [<ffffffffa0434a2d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898577] [<ffffffff8110b3c9>] ? kmem_cache_alloc+0x31/0xec
Nov 3 09:55:18 luna kernel: [ 939.898598] [<ffffffffa0470a40>] btrfs_insert_orphan_item+0x5d/0x75 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898619] [<ffffffffa0452474>] btrfs_orphan_add+0x107/0x124 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898640] [<ffffffffa0453c6d>] btrfs_truncate+0x35d/0x51c [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898661] [<ffffffffa0453eb6>] btrfs_setsize+0x8a/0x99 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898682] [<ffffffffa0453f26>] btrfs_setattr+0x61/0xa1 [btrfs]
Nov 3 09:55:18 luna kernel: [ 939.898687] [<ffffffff8112efdb>] notify_change+0x197/0x279
Nov 3 09:55:18 luna kernel: [ 939.898692] [<ffffffff81119646>] do_truncate+0x6a/0x87
Nov 3 09:55:18 luna kernel: [ 939.898697] [<ffffffff8112527c>] do_last+0x575/0x57a
Nov 3 09:55:18 luna kernel: [ 939.898702] [<ffffffff8112399e>] ? path_init+0xd1/0x2bc
Nov 3 09:55:18 luna kernel: [ 939.898706] [<ffffffff81125809>] path_openat+0xcf/0x313
Nov 3 09:55:18 luna kernel: [ 939.898710] [<ffffffff81125b46>] do_filp_open+0x3d/0x89
Nov 3 09:55:18 luna kernel: [ 939.898716] [<ffffffff811d105e>] ? strncpy_from_user+0x48/0x76
Nov 3 09:55:18 luna kernel: [ 939.898721] [<ffffffff8112fc9b>] ? alloc_fd+0x7b/0x123
Nov 3 09:55:18 luna kernel: [ 939.898725] [<ffffffff8111877f>] do_sys_open+0x73/0x105
Nov 3 09:55:18 luna kernel: [ 939.898729] [<ffffffff81118844>] sys_open+0x20/0x22
Nov 3 09:55:18 luna kernel: [ 939.898734] [<ffffffff813afac2>] system_call_fastpath+0x16/0x1b
Nov 3 09:55:18 luna kernel: [ 939.898738] ---[ end trace d460dfa0e8887bca ]---
Nov 3 09:55:18 luna kernel: [ 939.898758] btrfs: csum mismatch on free space cache
Nov 3 09:55:18 luna kernel: [ 939.898814] btrfs: failed to load free space cache for block group 29360128
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-03 1:25 WARNING: at fs/btrfs/free-space-cache.c:305 Tsutomu Itoh
@ 2011-11-03 11:19 ` Chris Mason
2011-11-03 23:43 ` Tsutomu Itoh
2011-11-09 15:17 ` Josef Bacik
1 sibling, 1 reply; 8+ messages in thread
From: Chris Mason @ 2011-11-03 11:19 UTC (permalink / raw)
To: Tsutomu Itoh; +Cc: Linux Btrfs
On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
> In integration-scrub branch, following warning messages were displayed by
> running xfstests.
>
> # btrfs fi sh /dev/sdd4
> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
> Total devices 2 FS bytes used 31.49MB
> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>
> Btrfs Btrfs v0.19
> # mount
> ...
> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
> #
>
> Thanks,
> Tsutomu
>
> ====================================================================================
>
> Nov 3 09:55:18 luna kernel: [ 939.732044] device fsid 8f28d85c-e37c-4c1b-adef-2627ca59be78 devid 1 transid 20510 /dev/sdd4
> Nov 3 09:55:18 luna kernel: [ 939.732533] btrfs: use lzo compression
> Nov 3 09:55:18 luna kernel: [ 939.732536] btrfs: disk space caching is enabled
> Nov 3 09:55:18 luna kernel: [ 939.898190] ------------[ cut here ]------------
> Nov 3 09:55:18 luna kernel: [ 939.898223] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
> Nov 3 09:55:18 luna kernel: [ 939.898227] Hardware name: PRIMERGY
> Nov 3 09:55:18 luna kernel: [ 939.898229] Modules linked in: btrfs zlib_deflate crc32c libcrc32c nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
> Nov 3 09:55:18 luna kernel: [ 939.898291] Pid: 13337, comm: dd Not tainted 3.1.0integ-sc+ #1
> Nov 3 09:55:18 luna kernel: [ 939.898294] Call Trace:
> Nov 3 09:55:18 luna kernel: [ 939.898303] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
> Nov 3 09:55:18 luna kernel: [ 939.898308] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
> Nov 3 09:55:18 luna kernel: [ 939.898328] [<ffffffffa0477507>] io_ctl_map_page+0x29/0x76 [btrfs]
> Nov 3 09:55:18 luna kernel: [ 939.898349] [<ffffffffa0477733>] io_ctl_check_crc+0x62/0xdd [btrfs]
Looks like io_ctl_read_bitmap will call io_ctl_check_crc with a mapped
page mapped. Any chance you're able to reproduce this?
-chris
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-03 11:19 ` Chris Mason
@ 2011-11-03 23:43 ` Tsutomu Itoh
2011-11-07 8:06 ` Tsutomu Itoh
0 siblings, 1 reply; 8+ messages in thread
From: Tsutomu Itoh @ 2011-11-03 23:43 UTC (permalink / raw)
To: Chris Mason; +Cc: Linux Btrfs
(2011/11/03 20:19), Chris Mason wrote:
> On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
>> In integration-scrub branch, following warning messages were displayed by
>> running xfstests.
>>
>> # btrfs fi sh /dev/sdd4
>> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
>> Total devices 2 FS bytes used 31.49MB
>> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
>> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>>
>> Btrfs Btrfs v0.19
>> # mount
>> ...
>> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
>> #
>>
>> Thanks,
>> Tsutomu
>>
>> ====================================================================================
>>
>> Nov 3 09:55:18 luna kernel: [ 939.732044] device fsid 8f28d85c-e37c-4c1b-adef-2627ca59be78 devid 1 transid 20510 /dev/sdd4
>> Nov 3 09:55:18 luna kernel: [ 939.732533] btrfs: use lzo compression
>> Nov 3 09:55:18 luna kernel: [ 939.732536] btrfs: disk space caching is enabled
>> Nov 3 09:55:18 luna kernel: [ 939.898190] ------------[ cut here ]------------
>> Nov 3 09:55:18 luna kernel: [ 939.898223] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
>> Nov 3 09:55:18 luna kernel: [ 939.898227] Hardware name: PRIMERGY
>> Nov 3 09:55:18 luna kernel: [ 939.898229] Modules linked in: btrfs zlib_deflate crc32c libcrc32c nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
>> Nov 3 09:55:18 luna kernel: [ 939.898291] Pid: 13337, comm: dd Not tainted 3.1.0integ-sc+ #1
>> Nov 3 09:55:18 luna kernel: [ 939.898294] Call Trace:
>> Nov 3 09:55:18 luna kernel: [ 939.898303] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
>> Nov 3 09:55:18 luna kernel: [ 939.898308] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
>> Nov 3 09:55:18 luna kernel: [ 939.898328] [<ffffffffa0477507>] io_ctl_map_page+0x29/0x76 [btrfs]
>> Nov 3 09:55:18 luna kernel: [ 939.898349] [<ffffffffa0477733>] io_ctl_check_crc+0x62/0xdd [btrfs]
>
> Looks like io_ctl_read_bitmap will call io_ctl_check_crc with a mapped
> page mapped. Any chance you're able to reproduce this?
Yes.
However, because the panic that David reported occurs, I cannot reproduce
this problem though I executed xfstests again.
Thanks,
Tsutomu
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-03 23:43 ` Tsutomu Itoh
@ 2011-11-07 8:06 ` Tsutomu Itoh
2011-11-07 16:06 ` Chris Mason
0 siblings, 1 reply; 8+ messages in thread
From: Tsutomu Itoh @ 2011-11-07 8:06 UTC (permalink / raw)
To: Chris Mason; +Cc: Linux Btrfs
[-- Attachment #1: Type: text/plain, Size: 2859 bytes --]
Hi, Chris,
(2011/11/04 8:43), Tsutomu Itoh wrote:
> (2011/11/03 20:19), Chris Mason wrote:
>> On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
>>> In integration-scrub branch, following warning messages were displayed by
>>> running xfstests.
>>>
>>> # btrfs fi sh /dev/sdd4
>>> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
>>> Total devices 2 FS bytes used 31.49MB
>>> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
>>> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>>>
>>> Btrfs Btrfs v0.19
>>> # mount
>>> ...
>>> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
>>> #
>>>
>>> Thanks,
>>> Tsutomu
>>>
>>> ====================================================================================
>>>
>>> Nov 3 09:55:18 luna kernel: [ 939.732044] device fsid 8f28d85c-e37c-4c1b-adef-2627ca59be78 devid 1 transid 20510 /dev/sdd4
>>> Nov 3 09:55:18 luna kernel: [ 939.732533] btrfs: use lzo compression
>>> Nov 3 09:55:18 luna kernel: [ 939.732536] btrfs: disk space caching is enabled
>>> Nov 3 09:55:18 luna kernel: [ 939.898190] ------------[ cut here ]------------
>>> Nov 3 09:55:18 luna kernel: [ 939.898223] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
>>> Nov 3 09:55:18 luna kernel: [ 939.898227] Hardware name: PRIMERGY
>>> Nov 3 09:55:18 luna kernel: [ 939.898229] Modules linked in: btrfs zlib_deflate crc32c libcrc32c nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
>>> Nov 3 09:55:18 luna kernel: [ 939.898291] Pid: 13337, comm: dd Not tainted 3.1.0integ-sc+ #1
>>> Nov 3 09:55:18 luna kernel: [ 939.898294] Call Trace:
>>> Nov 3 09:55:18 luna kernel: [ 939.898303] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
>>> Nov 3 09:55:18 luna kernel: [ 939.898308] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
>>> Nov 3 09:55:18 luna kernel: [ 939.898328] [<ffffffffa0477507>] io_ctl_map_page+0x29/0x76 [btrfs]
>>> Nov 3 09:55:18 luna kernel: [ 939.898349] [<ffffffffa0477733>] io_ctl_check_crc+0x62/0xdd [btrfs]
>>
>> Looks like io_ctl_read_bitmap will call io_ctl_check_crc with a mapped
>> page mapped. Any chance you're able to reproduce this?
>
> Yes.
> However, because the panic that David reported occurs, I cannot reproduce
> this problem though I executed xfstests again.
In for-linus branch, I was able to reproduce this problem.
The message log is attached to this mail.
Thanks,
Tsutomu
[-- Attachment #2: msg.log --]
[-- Type: text/plain, Size: 18900 bytes --]
Nov 7 15:16:28 luna kernel: [ 3010.347454] device fsid 9880be7d-1b7f-4233-b14d-c6bc37d3d26c devid 1 transid 7775 /dev/sdd4
Nov 7 15:16:28 luna kernel: [ 3010.347954] btrfs: disk space caching is enabled
Nov 7 15:16:28 luna kernel: [ 3010.398732] ------------[ cut here ]------------
Nov 7 15:16:28 luna kernel: [ 3010.398768] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
Nov 7 15:16:28 luna kernel: [ 3010.398772] Hardware name: PRIMERGY
Nov 7 15:16:28 luna kernel: [ 3010.398774] Modules linked in: nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 btrfs zlib_deflate crc32c libcrc32c ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
Nov 7 15:16:28 luna kernel: [ 3010.398834] Pid: 11742, comm: mkdir Not tainted 3.1.0mod+ #1
Nov 7 15:16:28 luna kernel: [ 3010.398837] Call Trace:
Nov 7 15:16:28 luna kernel: [ 3010.398846] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
Nov 7 15:16:28 luna kernel: [ 3010.398851] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
Nov 7 15:16:28 luna kernel: [ 3010.398872] [<ffffffffa03035b0>] io_ctl_map_page+0x29/0x76 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.398893] [<ffffffffa0303790>] io_ctl_check_crc+0x62/0xd0 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.398899] [<ffffffff811cb564>] ? rb_insert_color+0x68/0xe5
Nov 7 15:16:28 luna kernel: [ 3010.398919] [<ffffffffa0303832>] io_ctl_read_bitmap+0x34/0x61 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.398941] [<ffffffffa0303202>] ? link_free_space+0x3f/0x54 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.398961] [<ffffffffa030528c>] __load_free_space_cache+0x2f1/0x35a [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.398967] [<ffffffff8112d21d>] ? igrab+0x1d/0x44
Nov 7 15:16:28 luna kernel: [ 3010.398988] [<ffffffffa030548e>] load_free_space_cache+0xca/0x168 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399004] [<ffffffffa02c7507>] cache_block_group+0xa3/0x1f2 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399034] [<ffffffffa02cabf4>] find_free_extent+0x478/0xa48 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399041] [<ffffffff81014ea2>] ? read_tsc+0x9/0x1b
Nov 7 15:16:28 luna kernel: [ 3010.399049] [<ffffffff810d35bc>] ? __lock_page+0x6d/0x6d
Nov 7 15:16:28 luna kernel: [ 3010.399068] [<ffffffffa02cb279>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399076] [<ffffffff810675a2>] ? autoremove_wake_function+0x3d/0x3d
Nov 7 15:16:28 luna kernel: [ 3010.399095] [<ffffffffa02cb508>] btrfs_alloc_free_block+0x180/0x2a8 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399111] [<ffffffffa02bd3b2>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399136] [<ffffffffa02ec297>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399153] [<ffffffffa02bdb36>] btrfs_cow_block+0x108/0x152 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399170] [<ffffffffa02bf855>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399187] [<ffffffffa02bceb4>] ? btrfs_free_path+0x2a/0x2f [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399204] [<ffffffffa02c088d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399228] [<ffffffffa02da665>] btrfs_new_inode+0x160/0x36d [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399250] [<ffffffffa02d6f00>] ? start_transaction+0x200/0x24d [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399273] [<ffffffffa02ddf30>] btrfs_mkdir+0xbd/0x1ab [btrfs]
Nov 7 15:16:28 luna kernel: [ 3010.399281] [<ffffffff81123f61>] vfs_mkdir+0x5f/0x9b
Nov 7 15:16:28 luna kernel: [ 3010.399287] [<ffffffff811262c6>] sys_mkdirat+0x6b/0xaa
Nov 7 15:16:28 luna kernel: [ 3010.399294] [<ffffffff8112631d>] sys_mkdir+0x18/0x1a
Nov 7 15:16:28 luna kernel: [ 3010.399301] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
Nov 7 15:16:28 luna kernel: [ 3010.399306] ---[ end trace 3f7da847bea10c5d ]---
Nov 7 15:16:28 luna kernel: [ 3010.399327] btrfs: csum mismatch on free space cache
Nov 7 15:16:28 luna kernel: [ 3010.399585] btrfs: failed to load free space cache for block group 29360128
...
...
Nov 7 15:32:18 luna kernel: [ 3960.655338] device fsid 9880be7d-1b7f-4233-b14d-c6bc37d3d26c devid 1 transid 8092 /dev/sdd4
Nov 7 15:32:18 luna kernel: [ 3960.655855] btrfs: disk space caching is enabled
Nov 7 15:32:18 luna kernel: [ 3960.844130] ------------[ cut here ]------------
Nov 7 15:32:18 luna kernel: [ 3960.844168] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
Nov 7 15:32:18 luna kernel: [ 3960.844171] Hardware name: PRIMERGY
Nov 7 15:32:18 luna kernel: [ 3960.844173] Modules linked in: nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 btrfs zlib_deflate crc32c libcrc32c ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
Nov 7 15:32:18 luna kernel: [ 3960.844233] Pid: 8238, comm: rm Tainted: G W 3.1.0mod+ #1
Nov 7 15:32:18 luna kernel: [ 3960.844236] Call Trace:
Nov 7 15:32:18 luna kernel: [ 3960.844245] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
Nov 7 15:32:18 luna kernel: [ 3960.844250] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
Nov 7 15:32:18 luna kernel: [ 3960.844270] [<ffffffffa03035b0>] io_ctl_map_page+0x29/0x76 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844291] [<ffffffffa0303790>] io_ctl_check_crc+0x62/0xd0 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844312] [<ffffffffa0303832>] io_ctl_read_bitmap+0x34/0x61 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844334] [<ffffffffa0303202>] ? link_free_space+0x3f/0x54 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844354] [<ffffffffa030528c>] __load_free_space_cache+0x2f1/0x35a [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844360] [<ffffffff8112d21d>] ? igrab+0x1d/0x44
Nov 7 15:32:18 luna kernel: [ 3960.844380] [<ffffffffa030548e>] load_free_space_cache+0xca/0x168 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844397] [<ffffffffa02c7507>] cache_block_group+0xa3/0x1f2 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844414] [<ffffffffa02cabf4>] find_free_extent+0x478/0xa48 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844432] [<ffffffffa02cb279>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844455] [<ffffffffa02ec297>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844472] [<ffffffffa02cb508>] btrfs_alloc_free_block+0x180/0x2a8 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844477] [<ffffffff8112d786>] ? unlock_new_inode+0x50/0x5a
Nov 7 15:32:18 luna kernel: [ 3960.844492] [<ffffffffa02bd3b2>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844513] [<ffffffffa02e0822>] ? btrfs_lookup_dentry+0x14f/0x400 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844529] [<ffffffffa02bdb36>] btrfs_cow_block+0x108/0x152 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844544] [<ffffffffa02bf855>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844549] [<ffffffff811238c1>] ? inode_permission+0xd2/0xde
Nov 7 15:32:18 luna kernel: [ 3960.844564] [<ffffffffa02c088d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844569] [<ffffffff8110b3c9>] ? kmem_cache_alloc+0x31/0xec
Nov 7 15:32:18 luna kernel: [ 3960.844591] [<ffffffffa02fcef8>] btrfs_insert_orphan_item+0x5d/0x75 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844614] [<ffffffffa02de8f1>] btrfs_orphan_add+0x107/0x125 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844635] [<ffffffffa02deeea>] btrfs_rmdir+0xb7/0x120 [btrfs]
Nov 7 15:32:18 luna kernel: [ 3960.844640] [<ffffffff8112436b>] vfs_rmdir+0x87/0xe1
Nov 7 15:32:18 luna kernel: [ 3960.844644] [<ffffffff811269f6>] do_rmdir+0xd0/0x122
Nov 7 15:32:18 luna kernel: [ 3960.844649] [<ffffffff81132266>] ? mntput+0x26/0x28
Nov 7 15:32:18 luna kernel: [ 3960.844653] [<ffffffff81122c69>] ? path_put+0x22/0x26
Nov 7 15:32:18 luna kernel: [ 3960.844658] [<ffffffff810971b7>] ? audit_syscall_entry+0x11e/0x14a
Nov 7 15:32:18 luna kernel: [ 3960.844662] [<ffffffff81126a6a>] sys_unlinkat+0x22/0x2b
Nov 7 15:32:18 luna kernel: [ 3960.844667] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
Nov 7 15:32:18 luna kernel: [ 3960.844671] ---[ end trace 3f7da847bea10c5e ]---
Nov 7 15:32:18 luna kernel: [ 3960.844692] btrfs: csum mismatch on free space cache
Nov 7 15:32:18 luna kernel: [ 3960.844951] btrfs: failed to load free space cache for block group 29360128
...
...
Nov 7 15:49:44 luna kernel: [ 5006.897832] device fsid 9880be7d-1b7f-4233-b14d-c6bc37d3d26c devid 1 transid 11042 /dev/sdd4
Nov 7 15:49:44 luna kernel: [ 5006.898379] btrfs: use lzo compression
Nov 7 15:49:44 luna kernel: [ 5006.898382] btrfs: disk space caching is enabled
Nov 7 15:49:44 luna kernel: [ 5007.077857] ------------[ cut here ]------------
Nov 7 15:49:44 luna kernel: [ 5007.077893] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
Nov 7 15:49:44 luna kernel: [ 5007.077897] Hardware name: PRIMERGY
Nov 7 15:49:44 luna kernel: [ 5007.077899] Modules linked in: nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 btrfs zlib_deflate crc32c libcrc32c ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
Nov 7 15:49:44 luna kernel: [ 5007.077959] Pid: 19907, comm: xfs_io Tainted: G W 3.1.0mod+ #1
Nov 7 15:49:44 luna kernel: [ 5007.077962] Call Trace:
Nov 7 15:49:44 luna kernel: [ 5007.077971] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
Nov 7 15:49:44 luna kernel: [ 5007.077976] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
Nov 7 15:49:44 luna kernel: [ 5007.077997] [<ffffffffa03035b0>] io_ctl_map_page+0x29/0x76 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078029] [<ffffffffa0303790>] io_ctl_check_crc+0x62/0xd0 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078052] [<ffffffffa0303832>] io_ctl_read_bitmap+0x34/0x61 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078076] [<ffffffffa0303202>] ? link_free_space+0x3f/0x54 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078099] [<ffffffffa030528c>] __load_free_space_cache+0x2f1/0x35a [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078107] [<ffffffff8112d21d>] ? igrab+0x1d/0x44
Nov 7 15:49:44 luna kernel: [ 5007.078129] [<ffffffffa030548e>] load_free_space_cache+0xca/0x168 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078136] [<ffffffff8111688b>] ? lookup_page_cgroup+0x28/0x3e
Nov 7 15:49:44 luna kernel: [ 5007.078154] [<ffffffffa02c7507>] cache_block_group+0xa3/0x1f2 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078174] [<ffffffffa02cabf4>] find_free_extent+0x478/0xa48 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078193] [<ffffffffa02cb279>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078212] [<ffffffffa02cb508>] btrfs_alloc_free_block+0x180/0x2a8 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078229] [<ffffffffa02bd3b2>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078254] [<ffffffffa02ec297>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078271] [<ffffffffa02bdb36>] btrfs_cow_block+0x108/0x152 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078288] [<ffffffffa02bf855>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078295] [<ffffffff8110946c>] ? virt_to_head_page+0xe/0x31
Nov 7 15:49:44 luna kernel: [ 5007.078311] [<ffffffffa02bceb4>] ? btrfs_free_path+0x2a/0x2f [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078328] [<ffffffffa02c088d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078352] [<ffffffffa02da665>] btrfs_new_inode+0x160/0x36d [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078374] [<ffffffffa02d6f00>] ? start_transaction+0x200/0x24d [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078397] [<ffffffffa02dd710>] btrfs_create+0xae/0x19a [btrfs]
Nov 7 15:49:44 luna kernel: [ 5007.078405] [<ffffffff811240c8>] vfs_create+0x6c/0x8e
Nov 7 15:49:44 luna kernel: [ 5007.078411] [<ffffffff81124f3e>] do_last+0x237/0x57a
Nov 7 15:49:44 luna kernel: [ 5007.078417] [<ffffffff81125809>] path_openat+0xcf/0x313
Nov 7 15:49:44 luna kernel: [ 5007.078424] [<ffffffff81125b46>] do_filp_open+0x3d/0x89
Nov 7 15:49:44 luna kernel: [ 5007.078431] [<ffffffff811d149e>] ? strncpy_from_user+0x48/0x76
Nov 7 15:49:44 luna kernel: [ 5007.078438] [<ffffffff8112fc9b>] ? alloc_fd+0x7b/0x123
Nov 7 15:49:44 luna kernel: [ 5007.078445] [<ffffffff8111877f>] do_sys_open+0x73/0x105
Nov 7 15:49:44 luna kernel: [ 5007.078451] [<ffffffff81118844>] sys_open+0x20/0x22
Nov 7 15:49:44 luna kernel: [ 5007.078458] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
Nov 7 15:49:44 luna kernel: [ 5007.078463] ---[ end trace 3f7da847bea10c5f ]---
Nov 7 15:49:44 luna kernel: [ 5007.078485] btrfs: csum mismatch on free space cache
Nov 7 15:49:44 luna kernel: [ 5007.079315] btrfs: failed to load free space cache for block group 29360128
...
...
Nov 7 16:20:16 luna kernel: [ 6838.353069] device fsid 9880be7d-1b7f-4233-b14d-c6bc37d3d26c devid 1 transid 14139 /dev/sdd4
Nov 7 16:20:16 luna kernel: [ 6838.353590] btrfs: use lzo compression
Nov 7 16:20:16 luna kernel: [ 6838.353593] btrfs: disk space caching is enabled
Nov 7 16:20:16 luna kernel: [ 6838.494401] ------------[ cut here ]------------
Nov 7 16:20:16 luna kernel: [ 6838.494438] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
Nov 7 16:20:16 luna kernel: [ 6838.494441] Hardware name: PRIMERGY
Nov 7 16:20:16 luna kernel: [ 6838.494444] Modules linked in: nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 btrfs zlib_deflate crc32c libcrc32c ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
Nov 7 16:20:16 luna kernel: [ 6838.494504] Pid: 20575, comm: touch Tainted: G W 3.1.0mod+ #1
Nov 7 16:20:16 luna kernel: [ 6838.494507] Call Trace:
Nov 7 16:20:16 luna kernel: [ 6838.494516] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
Nov 7 16:20:16 luna kernel: [ 6838.494521] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
Nov 7 16:20:16 luna kernel: [ 6838.494542] [<ffffffffa03035b0>] io_ctl_map_page+0x29/0x76 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494563] [<ffffffffa0303790>] io_ctl_check_crc+0x62/0xd0 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494569] [<ffffffff811cb564>] ? rb_insert_color+0x68/0xe5
Nov 7 16:20:16 luna kernel: [ 6838.494590] [<ffffffffa0303832>] io_ctl_read_bitmap+0x34/0x61 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494611] [<ffffffffa0303202>] ? link_free_space+0x3f/0x54 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494632] [<ffffffffa030528c>] __load_free_space_cache+0x2f1/0x35a [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494638] [<ffffffff8112d21d>] ? igrab+0x1d/0x44
Nov 7 16:20:16 luna kernel: [ 6838.494658] [<ffffffffa030548e>] load_free_space_cache+0xca/0x168 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494663] [<ffffffff8110b3c9>] ? kmem_cache_alloc+0x31/0xec
Nov 7 16:20:16 luna kernel: [ 6838.494680] [<ffffffffa02c7507>] cache_block_group+0xa3/0x1f2 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494697] [<ffffffffa02cabf4>] find_free_extent+0x478/0xa48 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494715] [<ffffffffa02cb279>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494732] [<ffffffffa02cb508>] btrfs_alloc_free_block+0x180/0x2a8 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494747] [<ffffffffa02bd3b2>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494770] [<ffffffffa02ec297>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494785] [<ffffffffa02bdb36>] btrfs_cow_block+0x108/0x152 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494800] [<ffffffffa02bf855>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494805] [<ffffffff8110946c>] ? virt_to_head_page+0xe/0x31
Nov 7 16:20:16 luna kernel: [ 6838.494820] [<ffffffffa02bceb4>] ? btrfs_free_path+0x2a/0x2f [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494835] [<ffffffffa02c088d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494857] [<ffffffffa02da665>] btrfs_new_inode+0x160/0x36d [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494877] [<ffffffffa02d6f00>] ? start_transaction+0x200/0x24d [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494898] [<ffffffffa02dd710>] btrfs_create+0xae/0x19a [btrfs]
Nov 7 16:20:16 luna kernel: [ 6838.494904] [<ffffffff811240c8>] vfs_create+0x6c/0x8e
Nov 7 16:20:16 luna kernel: [ 6838.494908] [<ffffffff81124f3e>] do_last+0x237/0x57a
Nov 7 16:20:16 luna kernel: [ 6838.494912] [<ffffffff81125809>] path_openat+0xcf/0x313
Nov 7 16:20:16 luna kernel: [ 6838.494917] [<ffffffff81125b46>] do_filp_open+0x3d/0x89
Nov 7 16:20:16 luna kernel: [ 6838.494922] [<ffffffff811d149e>] ? strncpy_from_user+0x48/0x76
Nov 7 16:20:16 luna kernel: [ 6838.494927] [<ffffffff8112fc9b>] ? alloc_fd+0x7b/0x123
Nov 7 16:20:16 luna kernel: [ 6838.494932] [<ffffffff8111877f>] do_sys_open+0x73/0x105
Nov 7 16:20:16 luna kernel: [ 6838.494936] [<ffffffff81118844>] sys_open+0x20/0x22
Nov 7 16:20:16 luna kernel: [ 6838.494941] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
Nov 7 16:20:16 luna kernel: [ 6838.494945] ---[ end trace 3f7da847bea10c60 ]---
Nov 7 16:20:16 luna kernel: [ 6838.495117] btrfs: csum mismatch on free space cache
Nov 7 16:20:16 luna kernel: [ 6838.495374] btrfs: failed to load free space cache for block group 29360128
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-07 8:06 ` Tsutomu Itoh
@ 2011-11-07 16:06 ` Chris Mason
0 siblings, 0 replies; 8+ messages in thread
From: Chris Mason @ 2011-11-07 16:06 UTC (permalink / raw)
To: Tsutomu Itoh; +Cc: Linux Btrfs
On Mon, Nov 07, 2011 at 05:06:32PM +0900, Tsutomu Itoh wrote:
> Hi, Chris,
>
> (2011/11/04 8:43), Tsutomu Itoh wrote:
> > (2011/11/03 20:19), Chris Mason wrote:
> >> On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
> >>> In integration-scrub branch, following warning messages were displayed by
> >>> running xfstests.
> >>>
> >>> # btrfs fi sh /dev/sdd4
> >>> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
> >>> Total devices 2 FS bytes used 31.49MB
> >>> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
> >>> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
> >>>
> >>> Btrfs Btrfs v0.19
> >>> # mount
> >>> ...
> >>> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
> >>> #
> >>>
> >>> Thanks,
> >>> Tsutomu
> >>>
> >>> ====================================================================================
> >>>
> >>> Nov 3 09:55:18 luna kernel: [ 939.732044] device fsid 8f28d85c-e37c-4c1b-adef-2627ca59be78 devid 1 transid 20510 /dev/sdd4
> >>> Nov 3 09:55:18 luna kernel: [ 939.732533] btrfs: use lzo compression
> >>> Nov 3 09:55:18 luna kernel: [ 939.732536] btrfs: disk space caching is enabled
> >>> Nov 3 09:55:18 luna kernel: [ 939.898190] ------------[ cut here ]------------
> >>> Nov 3 09:55:18 luna kernel: [ 939.898223] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
> >>> Nov 3 09:55:18 luna kernel: [ 939.898227] Hardware name: PRIMERGY
> >>> Nov 3 09:55:18 luna kernel: [ 939.898229] Modules linked in: btrfs zlib_deflate crc32c libcrc32c nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
> >>> Nov 3 09:55:18 luna kernel: [ 939.898291] Pid: 13337, comm: dd Not tainted 3.1.0integ-sc+ #1
> >>> Nov 3 09:55:18 luna kernel: [ 939.898294] Call Trace:
> >>> Nov 3 09:55:18 luna kernel: [ 939.898303] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
> >>> Nov 3 09:55:18 luna kernel: [ 939.898308] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
> >>> Nov 3 09:55:18 luna kernel: [ 939.898328] [<ffffffffa0477507>] io_ctl_map_page+0x29/0x76 [btrfs]
> >>> Nov 3 09:55:18 luna kernel: [ 939.898349] [<ffffffffa0477733>] io_ctl_check_crc+0x62/0xdd [btrfs]
> >>
> >> Looks like io_ctl_read_bitmap will call io_ctl_check_crc with a mapped
> >> page mapped. Any chance you're able to reproduce this?
> >
> > Yes.
> > However, because the panic that David reported occurs, I cannot reproduce
> > this problem though I executed xfstests again.
>
> In for-linus branch, I was able to reproduce this problem.
> The message log is attached to this mail.
Great, the traces clearly show io_ctl_read_bitmap is leaving a page
mapped and that io_ctl_check_crc is trying to map it again.
Josef, looks like io_ctl_read_bitmap needs to always unmap?
[ trace below ]
-chris
>
> Thanks,
> Tsutomu
> Nov 7 15:16:28 luna kernel: [ 3010.347454] device fsid 9880be7d-1b7f-4233-b14d-c6bc37d3d26c devid 1 transid 7775 /dev/sdd4
> Nov 7 15:16:28 luna kernel: [ 3010.347954] btrfs: disk space caching is enabled
> Nov 7 15:16:28 luna kernel: [ 3010.398732] ------------[ cut here ]------------
> Nov 7 15:16:28 luna kernel: [ 3010.398768] WARNING: at fs/btrfs/free-space-cache.c:305 io_ctl_map_page+0x29/0x76 [btrfs]()
> Nov 7 15:16:28 luna kernel: [ 3010.398772] Hardware name: PRIMERGY
> Nov 7 15:16:28 luna kernel: [ 3010.398774] Modules linked in: nfsd lockd nfs_acl auth_rpcgss autofs4 sunrpc 8021q garp stp llc cpufreq_ondemand acpi_cpufreq freq_table mperf cachefiles fscache ipv6 btrfs zlib_deflate crc32c libcrc32c ext3 jbd dm_mirror dm_region_hash dm_log dm_mod kvm uinput ppdev parport_pc parport sg pcspkr i2c_i801 i2c_core iTCO_wdt iTCO_vendor_support tg3 shpchp pci_hotplug i3000_edac edac_core ext4 mbcache jbd2 crc16 sd_mod crc_t10dif megaraid_sas sr_mod cdrom floppy pata_acpi ata_generic ata_piix libata scsi_mod [last unloaded: microcode]
> Nov 7 15:16:28 luna kernel: [ 3010.398834] Pid: 11742, comm: mkdir Not tainted 3.1.0mod+ #1
> Nov 7 15:16:28 luna kernel: [ 3010.398837] Call Trace:
> Nov 7 15:16:28 luna kernel: [ 3010.398846] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
> Nov 7 15:16:28 luna kernel: [ 3010.398851] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
> Nov 7 15:16:28 luna kernel: [ 3010.398872] [<ffffffffa03035b0>] io_ctl_map_page+0x29/0x76 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.398893] [<ffffffffa0303790>] io_ctl_check_crc+0x62/0xd0 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.398899] [<ffffffff811cb564>] ? rb_insert_color+0x68/0xe5
> Nov 7 15:16:28 luna kernel: [ 3010.398919] [<ffffffffa0303832>] io_ctl_read_bitmap+0x34/0x61 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.398941] [<ffffffffa0303202>] ? link_free_space+0x3f/0x54 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.398961] [<ffffffffa030528c>] __load_free_space_cache+0x2f1/0x35a [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.398967] [<ffffffff8112d21d>] ? igrab+0x1d/0x44
> Nov 7 15:16:28 luna kernel: [ 3010.398988] [<ffffffffa030548e>] load_free_space_cache+0xca/0x168 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399004] [<ffffffffa02c7507>] cache_block_group+0xa3/0x1f2 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399034] [<ffffffffa02cabf4>] find_free_extent+0x478/0xa48 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399041] [<ffffffff81014ea2>] ? read_tsc+0x9/0x1b
> Nov 7 15:16:28 luna kernel: [ 3010.399049] [<ffffffff810d35bc>] ? __lock_page+0x6d/0x6d
> Nov 7 15:16:28 luna kernel: [ 3010.399068] [<ffffffffa02cb279>] btrfs_reserve_extent+0xb5/0x1c4 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399076] [<ffffffff810675a2>] ? autoremove_wake_function+0x3d/0x3d
> Nov 7 15:16:28 luna kernel: [ 3010.399095] [<ffffffffa02cb508>] btrfs_alloc_free_block+0x180/0x2a8 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399111] [<ffffffffa02bd3b2>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399136] [<ffffffffa02ec297>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399153] [<ffffffffa02bdb36>] btrfs_cow_block+0x108/0x152 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399170] [<ffffffffa02bf855>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399187] [<ffffffffa02bceb4>] ? btrfs_free_path+0x2a/0x2f [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399204] [<ffffffffa02c088d>] btrfs_insert_empty_items+0x6a/0xbc [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399228] [<ffffffffa02da665>] btrfs_new_inode+0x160/0x36d [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399250] [<ffffffffa02d6f00>] ? start_transaction+0x200/0x24d [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399273] [<ffffffffa02ddf30>] btrfs_mkdir+0xbd/0x1ab [btrfs]
> Nov 7 15:16:28 luna kernel: [ 3010.399281] [<ffffffff81123f61>] vfs_mkdir+0x5f/0x9b
> Nov 7 15:16:28 luna kernel: [ 3010.399287] [<ffffffff811262c6>] sys_mkdirat+0x6b/0xaa
> Nov 7 15:16:28 luna kernel: [ 3010.399294] [<ffffffff8112631d>] sys_mkdir+0x18/0x1a
> Nov 7 15:16:28 luna kernel: [ 3010.399301] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
> Nov 7 15:16:28 luna kernel: [ 3010.399306] ---[ end trace 3f7da847bea10c5d ]---
> Nov 7 15:16:28 luna kernel: [ 3010.399327] btrfs: csum mismatch on free space cache
> Nov 7 15:16:28 luna kernel: [ 3010.399585] btrfs: failed to load free space cache for block group 29360128
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-03 1:25 WARNING: at fs/btrfs/free-space-cache.c:305 Tsutomu Itoh
2011-11-03 11:19 ` Chris Mason
@ 2011-11-09 15:17 ` Josef Bacik
2011-11-09 23:38 ` Tsutomu Itoh
2011-11-10 8:36 ` Tsutomu Itoh
1 sibling, 2 replies; 8+ messages in thread
From: Josef Bacik @ 2011-11-09 15:17 UTC (permalink / raw)
To: Tsutomu Itoh; +Cc: Linux Btrfs, Chris Mason
On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
> In integration-scrub branch, following warning messages were displayed by
> running xfstests.
>
> # btrfs fi sh /dev/sdd4
> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
> Total devices 2 FS bytes used 31.49MB
> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>
> Btrfs Btrfs v0.19
> # mount
> ...
> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
> #
>
Can you try this patch I just posted?
[PATCH] Btrfs: only map pages if we know we need them when reading the space
cache
Thanks,
Josef
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-09 15:17 ` Josef Bacik
@ 2011-11-09 23:38 ` Tsutomu Itoh
2011-11-10 8:36 ` Tsutomu Itoh
1 sibling, 0 replies; 8+ messages in thread
From: Tsutomu Itoh @ 2011-11-09 23:38 UTC (permalink / raw)
To: Josef Bacik; +Cc: Linux Btrfs, Chris Mason
Hi, Josef,
(2011/11/10 0:17), Josef Bacik wrote:
> On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
>> In integration-scrub branch, following warning messages were displayed by
>> running xfstests.
>>
>> # btrfs fi sh /dev/sdd4
>> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
>> Total devices 2 FS bytes used 31.49MB
>> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
>> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>>
>> Btrfs Btrfs v0.19
>> # mount
>> ...
>> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
>> #
>>
>
> Can you try this patch I just posted?
OK, I'll try this.
Thanks,
Tsutomu
>
> [PATCH] Btrfs: only map pages if we know we need them when reading the space
> cache
>
> Thanks,
>
> Josef
>
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: WARNING: at fs/btrfs/free-space-cache.c:305
2011-11-09 15:17 ` Josef Bacik
2011-11-09 23:38 ` Tsutomu Itoh
@ 2011-11-10 8:36 ` Tsutomu Itoh
1 sibling, 0 replies; 8+ messages in thread
From: Tsutomu Itoh @ 2011-11-10 8:36 UTC (permalink / raw)
To: Josef Bacik; +Cc: Linux Btrfs, Chris Mason
(2011/11/10 0:17), Josef Bacik wrote:
> On Thu, Nov 03, 2011 at 10:25:23AM +0900, Tsutomu Itoh wrote:
>> In integration-scrub branch, following warning messages were displayed by
>> running xfstests.
>>
>> # btrfs fi sh /dev/sdd4
>> Label: none uuid: 8f28d85c-e37c-4c1b-adef-2627ca59be78
>> Total devices 2 FS bytes used 31.49MB
>> devid 1 size 9.31GB used 9.31GB path /dev/sdd4
>> devid 2 size 15.01GB used 9.29GB path /dev/sdc1
>>
>> Btrfs Btrfs v0.19
>> # mount
>> ...
>> /dev/sdd4 on /test7 type btrfs (rw,compress=lzo)
>> #
>>
>
> Can you try this patch I just posted?
>
> [PATCH] Btrfs: only map pages if we know we need them when reading the space
> cache
I applied your patch and running xfstests for about four hours,
this warning message was not displayed.
Thank you for your work.
- Tsutomu
^ permalink raw reply [flat|nested] 8+ messages in thread
end of thread, other threads:[~2011-11-10 8:36 UTC | newest]
Thread overview: 8+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2011-11-03 1:25 WARNING: at fs/btrfs/free-space-cache.c:305 Tsutomu Itoh
2011-11-03 11:19 ` Chris Mason
2011-11-03 23:43 ` Tsutomu Itoh
2011-11-07 8:06 ` Tsutomu Itoh
2011-11-07 16:06 ` Chris Mason
2011-11-09 15:17 ` Josef Bacik
2011-11-09 23:38 ` Tsutomu Itoh
2011-11-10 8:36 ` Tsutomu Itoh
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.