From: Tsutomu Itoh <t-itoh@jp.fujitsu.com>
To: linux-btrfs@vger.kernel.org
Cc: chris.mason@oracle.com
Subject: Re: BUG at fs/btrfs/file.c:1656 [for-linus]
Date: Mon, 14 Nov 2011 12:16:28 +0900 [thread overview]
Message-ID: <4EC0880C.1000904@jp.fujitsu.com> (raw)
In-Reply-To: <20111108171347.GS12759@twin.jikos.cz>
(2011/11/09 2:13), David Sterba wrote:
> Hi,
>
> a new BUG_ON on for-linus branch with
In current for-linus branch (8965593e41dd2d0e2a2f1e6f245336005ea94a2c),
I encountered following warning message and same BUG_ON() by running
xfstests/269.
FSTYP -- btrfs
PLATFORM -- Linux/x86_64 luna 3.1.0btrfs+
MKFS_OPTIONS -- /dev/sdd5
MOUNT_OPTIONS -- -o compress=lzo /dev/sdd5 /test9
-Tsutomu
=========================================================================
[ 2028.064760] device fsid 53b21281-ea7a-4a7b-97f4-fe60f491e678 devid 1 transid 4 /dev/sdd5
[ 2028.064920] btrfs: use lzo compression
[ 2028.064923] btrfs: disk space caching is enabled
[ 2030.986937] btrfs: block rsv returned -28
[ 2030.986940] ------------[ cut here ]------------
[ 2030.986968] WARNING: at fs/btrfs/extent-tree.c:5918 btrfs_alloc_free_block+0x100/0x2aa [btrfs]()
[ 2030.986971] Hardware name: PRIMERGY
[ 2030.986973] 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]
[ 2030.987068] Pid: 21544, comm: btrfs-endio-wri Not tainted 3.1.0btrfs+ #1
[ 2030.987072] Call Trace:
[ 2030.987083] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
[ 2030.987090] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
[ 2030.987106] [<ffffffffa043f48a>] btrfs_alloc_free_block+0x100/0x2aa [btrfs]
[ 2030.987127] [<ffffffffa0461a63>] ? merge_state+0xa6/0x11d [btrfs]
[ 2030.987141] [<ffffffffa04313aa>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
[ 2030.987156] [<ffffffffa0431b2e>] btrfs_cow_block+0x108/0x152 [btrfs]
[ 2030.987169] [<ffffffffa042e548>] ? unlock_up+0xbd/0xee [btrfs]
[ 2030.987184] [<ffffffffa043384d>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
[ 2030.987201] [<ffffffffa044137d>] btrfs_lookup_file_extent+0x3d/0x3f [btrfs]
[ 2030.987215] [<ffffffffa0430f26>] ? btrfs_alloc_path+0x1a/0x1c [btrfs]
[ 2030.987235] [<ffffffffa045744c>] btrfs_drop_extents+0x11a/0x762 [btrfs]
[ 2030.987243] [<ffffffff811caa20>] ? radix_tree_tag_clear+0xa6/0x109
[ 2030.987264] [<ffffffffa0460636>] ? free_extent_state+0x48/0x4c [btrfs]
[ 2030.987271] [<ffffffff8110b3c9>] ? kmem_cache_alloc+0x31/0xec
[ 2030.987291] [<ffffffffa0453174>] insert_reserved_file_extent.clone.0+0x79/0x232 [btrfs]
[ 2030.987310] [<ffffffffa044af4c>] ? start_transaction+0x200/0x24d [btrfs]
[ 2030.987330] [<ffffffffa04537a9>] btrfs_finish_ordered_io+0x1db/0x2cf [btrfs]
[ 2030.987336] [<ffffffff8110adf5>] ? __slab_free+0xde/0x1ac
[ 2030.987356] [<ffffffffa04538fc>] btrfs_writepage_end_io_hook+0x5f/0x79 [btrfs]
[ 2030.987375] [<ffffffffa047b0ce>] end_compressed_bio_write+0x6e/0xcd [btrfs]
[ 2030.987382] [<ffffffff81141943>] bio_endio+0x2d/0x2f
[ 2030.987400] [<ffffffffa0445a52>] end_workqueue_fn+0x111/0x120 [btrfs]
[ 2030.987420] [<ffffffffa046ba8b>] worker_loop+0x18a/0x4bb [btrfs]
[ 2030.987440] [<ffffffffa046b901>] ? btrfs_queue_worker+0x224/0x224 [btrfs]
[ 2030.987460] [<ffffffffa046b901>] ? btrfs_queue_worker+0x224/0x224 [btrfs]
[ 2030.987466] [<ffffffff81067114>] kthread+0x82/0x8a
[ 2030.987474] [<ffffffff813b1634>] kernel_thread_helper+0x4/0x10
[ 2030.987480] [<ffffffff81067092>] ? kthread_worker_fn+0x14a/0x14a
[ 2030.987486] [<ffffffff813b1630>] ? gs_change+0x13/0x13
[ 2030.987490] ---[ end trace 9ce03434806c2b10 ]---
[ 2030.987543] btrfs: block rsv returned -28
[ 2030.987547] ------------[ cut here ]------------
[ 2030.987562] WARNING: at fs/btrfs/extent-tree.c:5918 btrfs_alloc_free_block+0x100/0x2aa [btrfs]()
[ 2030.987566] Hardware name: PRIMERGY
[ 2030.987569] 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]
[ 2030.987693] Pid: 21544, comm: btrfs-endio-wri Tainted: G W 3.1.0btrfs+ #1
[ 2030.987696] Call Trace:
[ 2030.987703] [<ffffffff8104b6fe>] warn_slowpath_common+0x85/0x9d
[ 2030.987709] [<ffffffff8104b730>] warn_slowpath_null+0x1a/0x1c
[ 2030.987725] [<ffffffffa043f48a>] btrfs_alloc_free_block+0x100/0x2aa [btrfs]
[ 2030.987731] [<ffffffff811c9dc4>] ? __prop_inc_single+0x37/0x3c
[ 2030.987745] [<ffffffffa04313aa>] __btrfs_cow_block+0x11d/0x3ba [btrfs]
[ 2030.987760] [<ffffffffa0431b2e>] btrfs_cow_block+0x108/0x152 [btrfs]
[ 2030.987773] [<ffffffffa042e548>] ? unlock_up+0xbd/0xee [btrfs]
[ 2030.987788] [<ffffffffa043384d>] btrfs_search_slot+0x24e/0x6a9 [btrfs]
[ 2030.987808] [<ffffffffa046034f>] ? map_private_extent_buffer+0xa8/0xe8 [btrfs]
[ 2030.987825] [<ffffffffa044137d>] btrfs_lookup_file_extent+0x3d/0x3f [btrfs]
[ 2030.987839] [<ffffffffa0430f26>] ? btrfs_alloc_path+0x1a/0x1c [btrfs]
[ 2030.987859] [<ffffffffa045744c>] btrfs_drop_extents+0x11a/0x762 [btrfs]
[ 2030.987880] [<ffffffffa0460636>] ? free_extent_state+0x48/0x4c [btrfs]
[ 2030.987886] [<ffffffff8110b3c9>] ? kmem_cache_alloc+0x31/0xec
[ 2030.987906] [<ffffffffa0453174>] insert_reserved_file_extent.clone.0+0x79/0x232 [btrfs]
[ 2030.987925] [<ffffffffa044af4c>] ? start_transaction+0x200/0x24d [btrfs]
[ 2030.987945] [<ffffffffa04537a9>] btrfs_finish_ordered_io+0x1db/0x2cf [btrfs]
[ 2030.987965] [<ffffffffa04538fc>] btrfs_writepage_end_io_hook+0x5f/0x79 [btrfs]
[ 2030.987986] [<ffffffffa04629f6>] end_bio_extent_writepage+0xae/0x159 [btrfs]
[ 2030.987992] [<ffffffff81142808>] ? bio_free+0x64/0x69
[ 2030.987998] [<ffffffff81141943>] bio_endio+0x2d/0x2f
[ 2030.988024] [<ffffffffa0445a52>] end_workqueue_fn+0x111/0x120 [btrfs]
[ 2030.988044] [<ffffffffa046ba8b>] worker_loop+0x18a/0x4bb [btrfs]
[ 2030.988064] [<ffffffffa046b901>] ? btrfs_queue_worker+0x224/0x224 [btrfs]
[ 2030.988084] [<ffffffffa046b901>] ? btrfs_queue_worker+0x224/0x224 [btrfs]
[ 2030.988090] [<ffffffff81067114>] kthread+0x82/0x8a
[ 2030.988096] [<ffffffff813b1634>] kernel_thread_helper+0x4/0x10
[ 2030.988103] [<ffffffff81067092>] ? kthread_worker_fn+0x14a/0x14a
[ 2030.988108] [<ffffffff813b1630>] ? gs_change+0x13/0x13
[ 2030.988112] ---[ end trace 9ce03434806c2b11 ]---
[ 2031.073867] ------------[ cut here ]------------
[ 2031.074005] kernel BUG at fs/btrfs/file.c:1656!
[ 2031.074285] invalid opcode: 0000 [#1] SMP
[ 2031.074481] CPU 0
[ 2031.074481] 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]
[ 2031.074481]
[ 2031.074481] Pid: 21437, comm: fsstress Tainted: G W 3.1.0btrfs+ #1 FUJITSU-SV PRIMERGY /D2399
[ 2031.074481] RIP: 0010:[<ffffffffa0455ff8>] [<ffffffffa0455ff8>] btrfs_fallocate+0x1ac/0x325 [btrfs]
[ 2031.074481] RSP: 0018:ffff88014b7a7d58 EFLAGS: 00010202
[ 2031.074481] RAX: ffffffffffffffef RBX: ffff880177cdb6f0 RCX: 00000000004ce9ae
[ 2031.074481] RDX: ffff88014b7a7c68 RSI: 000060fe600045c0 RDI: 0000000000000000
[ 2031.074481] RBP: ffff88014b7a7e08 R08: ffffffffa0430eac R09: ffff88014b7a7c30
[ 2031.074481] R10: 0000000000000000 R11: ffff88017e384160 R12: ffffffffffffffef
[ 2031.074481] R13: 000000000015b000 R14: 0000000000134000 R15: 0000000000172000
[ 2031.074481] FS: 00007f1600479700(0000) GS:ffff88019fc00000(0000) knlGS:0000000000000000
[ 2031.074481] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 2031.074481] CR2: 00007f15fc0aa1a8 CR3: 000000017dd4e000 CR4: 00000000000006f0
[ 2031.074481] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 2031.074481] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 2031.074481] Process fsstress (pid: 21437, threadinfo ffff88014b7a6000, task ffff88015e825ac0)
[ 2031.074481] Stack:
[ 2031.074481] ffff88014b726000 00000000ffffff9c ffff88014b7a7d78 ffffffff8110946c
[ 2031.074481] 000000014b7a7da8 ffff880177cdb798 000000015e825ac0 fffffffffffff000
[ 2031.074481] ffff880177cdb590 00000000ffffff9c 0000000000000fff 0000000000171726
[ 2031.074481] Call Trace:
[ 2031.074481] [<ffffffff8110946c>] ? virt_to_head_page+0xe/0x31
[ 2031.074481] [<ffffffff81119506>] do_fallocate+0xf2/0x110
[ 2031.074481] [<ffffffff81127ad9>] ioctl_preallocate+0x73/0x7c
[ 2031.074481] [<ffffffff811282d5>] do_vfs_ioctl+0x414/0x4b8
[ 2031.074481] [<ffffffff811283cf>] sys_ioctl+0x56/0x7b
[ 2031.074481] [<ffffffff813af4c2>] system_call_fastpath+0x16/0x1b
[ 2031.074481] Code: 89 f8 45 31 c9 31 d2 4d 29 e8 31 f6 4c 89 e9 48 89 df e8 49 7b ff ff 48 85 c0 49 89 c4 74 0c 48 3d 00 f0 ff ff 0f 86 30 01 00 00 <0f> 0b eb fe 48 8b 53 50 49 39 d5 0f 82 80 00 00 00 49 8b 4c 24
[ 2031.074481] RIP [<ffffffffa0455ff8>] btrfs_fallocate+0x1ac/0x325 [btrfs]
[ 2031.074481] RSP <ffff88014b7a7d58>
>
> commit 45ea6095c8f0d6caad5658306416a5d254f1205e
> Author: slyich@gmail.com <slyich@gmail.com>
> Date: Mon Nov 7 16:08:01 2011 -0500
>
> btrfs: fix double-free 'tree_root' in 'btrfs_mount()'
>
> on top. Freshly created fs,
>
> === DF for /dev/sda5
> Data, RAID0: total=4.00GB, used=0.00
> Data: total=8.00MB, used=0.00
> System, RAID1: total=8.00MB, used=4.00KB
> System: total=4.00MB, used=0.00
> Metadata, RAID1: total=1.00GB, used=24.00KB
> Metadata: total=8.00MB, used=0.00
> === DF for /dev/sda9
> Data: total=8.00MB, used=0.00
> System, DUP: total=8.00MB, used=4.00KB
> System: total=4.00MB, used=0.00
> Metadata, DUP: total=1.00GB, used=24.00KB
> Metadata: total=8.00MB, used=0.00
>
> FSTYP -- btrfs
> PLATFORM -- Linux/x86_64 3.1.0-rc10-default+
> MKFS_OPTIONS -- /dev/sda9
> MOUNT_OPTIONS -- -o compress=lzo,discard,space_cache,autodefrag
> /dev/sda9 /mnt/a2
>
> xfstests/013 (tests running from 001 up to it)
>
> [ 267.150042] ------------[ cut here ]------------
> [ 267.152882] kernel BUG at fs/btrfs/file.c:1656!
> [ 267.152882] invalid opcode: 0000 [#1] SMP
> [ 267.152882] CPU 1
> [ 267.152882] Modules linked in: loop btrfs aoe
> [ 267.152882]
> [ 267.152882] Pid: 8324, comm: fsstress Not tainted 3.1.0-rc10-default+ #59
> [ 267.152882] RIP: 0010:[<ffffffffa0047d70>] [<ffffffffa0047d70>] btrfs_fallocate+0x380/0x3d0 [btrfs]
> [ 267.152882] RSP: 0018:ffff8800732b7e88 EFLAGS: 00010202
> [ 267.152882] RAX: ffffffffffffffef RBX: 0000000000112000 RCX: 0000000000000006
> [ 267.152882] RDX: 0000000000000001 RSI: ffff880077c6d078 RDI: 0000000000000000
> [ 267.220213] RBP: ffff8800732b7f38 R08: 0000000000000001 R09: 0000000000000001
> [ 267.220213] R10: 0000000000000001 R11: 0000000000000001 R12: ffffffffffffffef
> [ 267.220213] R13: 0000000000112000 R14: ffff88006f961be8 R15: 0000000000158000
> [ 267.220213] FS: 00007fd4d475e700(0000) GS:ffff88007de00000(0000) knlGS:0000000000000000
> [ 267.220213] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
> [ 267.220213] CR2: 00007fa5545d9000 CR3: 0000000077731000 CR4: 00000000000006e0
> [ 267.220213] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
> [ 267.220213] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
> [ 267.220213] Process fsstress (pid: 8324, threadinfo ffff8800732b6000, task ffff880077c6ca00)
> [ 267.220213] Stack:
> [ 267.220213] ffff880077c6ca00 ffff880077c6d078 ffff8800732b7ec8 ffff88006f9617f8
> [ 267.220213] 00000000000e3000 ffff88006f9618b0 0000000000157fff 0000000181143ef4
> [ 267.220213] ffff88006f961cc8 fffffffffffff000 0000000000000fff 0000000100000001
> [ 267.220213] Call Trace:
> [ 267.220213] [<ffffffff81141330>] do_fallocate+0xe0/0xf0
> [ 267.220213] [<ffffffff8114138e>] sys_fallocate+0x4e/0x80
> [ 267.220213] [<ffffffff81a1d742>] system_call_fastpath+0x16/0x1b
> [ 267.220213] Code: 8b 7d 90 e8 e3 b5 9c e1 e9 f2 fc ff ff 66 0f 1f 44 00 00 49 39 c7 48 89 c3 49 0f 46 df e9 12 ff ff ff 66 0f 1f 84 00 00 00 00 00 <0f> 0b 66 0f 1f 44 00 00 48 89 c7 4c 89 e3 4d 89 fd e8 8a b4 00
> [ 267.220213] RIP [<ffffffffa0047d70>] btrfs_fallocate+0x380/0x3d0 [btrfs]
> [ 267.220213] RSP <ffff8800732b7e88>
> [ 267.393603] ---[ end trace d0abb6e726d09321 ]---
>
> btrfs_fallocate():
> 1651 while (1) {
> 1652 u64 actual_end;
> 1653
> 1654 em = btrfs_get_extent(inode, NULL, 0, cur_offset,
> 1655 alloc_end - cur_offset, 0);
> 1656 BUG_ON(IS_ERR_OR_NULL(em));
>
> RAX says its -17 EEXIST. We saw this with raid10 + inode_cache, but this is not
> the case.
>
> the process that triggered it:
>
> D+ 17:52 0:00 rm -rf /mnt/a1/fsstress.8088.1 /mnt/a1/fsstress.8088.2
>
> $ cat /proc/8458/stack
> [<ffffffff81152205>] vfs_unlink+0x65/0x100
> [<ffffffff8115243b>] do_unlinkat+0x19b/0x1d0
> [<ffffffff811532b2>] sys_unlinkat+0x22/0x40
> [<ffffffff81a1d742>] system_call_fastpath+0x16/0x1b
> [<ffffffffffffffff>] 0xffffffffffffffff
>
>
> looks very similar to the "BUG at fs/btrfs/tree-log.c:3106" reported against
> integration-danger, though this branch does not contain the sub-trans logging
> patch.
>
>
> david
prev parent reply other threads:[~2011-11-14 3:16 UTC|newest]
Thread overview: 5+ messages / expand[flat|nested] mbox.gz Atom feed top
2011-11-08 17:13 BUG at fs/btrfs/file.c:1656 [for-linus] David Sterba
2011-11-08 17:45 ` Chris Mason
2011-11-08 18:25 ` David Sterba
2011-11-08 17:49 ` David Sterba
2011-11-14 3:16 ` Tsutomu Itoh [this message]
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=4EC0880C.1000904@jp.fujitsu.com \
--to=t-itoh@jp.fujitsu.com \
--cc=chris.mason@oracle.com \
--cc=linux-btrfs@vger.kernel.org \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).