Bug 60051 - Filebench varmail ternimates unexpectedly in btrfs 3.8.2
Summary: Filebench varmail ternimates unexpectedly in btrfs 3.8.2
Status: NEEDINFO
Alias: None
Product: File System
Classification: Unclassified
Component: btrfs (show other bugs)
Hardware: All Linux
: P1 blocking
Assignee: Josef Bacik
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2013-06-22 07:47 UTC by benlong zhang
Modified: 2013-07-03 13:04 UTC (History)
1 user (show)

See Also:
Kernel Version: 3.8.2
Tree: Mainline
Regression: No


Attachments

Description benlong zhang 2013-06-22 07:47:55 UTC
When I run filebench varmail test under btrfs of Linux kernel 3.8.2, I got this error:

[11496.552440] WARNING: at fs/btrfs/tree-log.c:3825 btrfs_log_inode_parent+0x28e/0x2f1 [btrfs]()
[11496.552560] Hardware name: PowerEdge R910
[11496.552644] Modules linked in: brd loop dm_crypt mperf coretemp kvm_intel snd_pcm kvm snd_timer snd usb_storage tpm_tis soundcore joydev psmouse snd_page_alloc tpm processor thermal_sys lpc_ich hid_generic serio_raw dcdbas ehci_pci evdev pcspkr tpm_bios microcode mfd_core button ext3 jbd mbcache dm_mod btrfs zlib_deflate crc32c libcrc32c sg sr_mod cdrom ses sd_mod enclosure crc_t10dif ata_generic usbhid hid qla2xxx scsi_transport_fc scsi_tgt crc32c_intel ata_piix uhci_hcd libata ehci_hcd megaraid_sas usbcore scsi_mod usb_common bnx2
[11496.556105] Pid: 4865, comm: filebench Tainted: G      D W    3.8.2-debug #60
[11496.556198] Call Trace:
[11496.556291]  [<ffffffff81040a43>] warn_slowpath_common+0x80/0x98
[11496.556384]  [<ffffffff81040a70>] warn_slowpath_null+0x15/0x17
[11496.556506]  [<ffffffffa027e34c>] btrfs_log_inode_parent+0x28e/0x2f1 [btrfs]
[11496.556634]  [<ffffffffa027e443>] btrfs_log_dentry_safe+0x38/0x51 [btrfs]
[11496.556758]  [<ffffffffa025e597>] btrfs_sync_file+0x162/0x1e5 [btrfs]
[11496.556854]  [<ffffffff8114e37d>] vfs_fsync_range+0x18/0x21
[11496.556944]  [<ffffffff8114e39d>] vfs_fsync+0x17/0x19
[11496.557033]  [<ffffffff8114e558>] do_fsync+0x35/0x53
[11496.557125]  [<ffffffff811ef729>] ? lockdep_sys_exit_thunk+0x35/0x67
[11496.557218]  [<ffffffff8114e593>] sys_fsync+0xb/0xf
[11496.557309]  [<ffffffff813ba7a9>] system_call_fastpath+0x16/0x1b
[11496.557400] ---[ end trace 568976af2f674ce7 ]---

And the benchmark will subsequently terminate unexpectedly with following exception:

[11502.598111] BUG: unable to handle kernel NULL pointer dereference at           (null)
[11502.598333] IP: [<ffffffffa02626bb>] write_extent_buffer+0x99/0x10e [btrfs]
[11502.598528] PGD 7f63dd067 PUD 7f60a3067 PMD 0 
[11502.598762] Oops: 0000 [#17] SMP 
[11502.598943] Modules linked in: brd loop dm_crypt mperf coretemp kvm_intel snd_pcm kvm snd_timer snd usb_storage tpm_tis soundcore joydev psmouse snd_page_alloc tpm processor thermal_sys lpc_ich hid_generic serio_raw dcdbas ehci_pci evdev pcspkr tpm_bios microcode mfd_core button ext3 jbd mbcache dm_mod btrfs zlib_deflate crc32c libcrc32c sg sr_mod cdrom ses sd_mod enclosure crc_t10dif ata_generic usbhid hid qla2xxx scsi_transport_fc scsi_tgt crc32c_intel ata_piix uhci_hcd libata ehci_hcd megaraid_sas usbcore scsi_mod usb_common bnx2
[11502.602366] CPU 4 
[11502.602428] Pid: 4865, comm: filebench Tainted: G      D W    3.8.2-debug #60 Dell Inc. PowerEdge R910/0P703H
[11502.602618] RIP: 0010:[<ffffffffa02626bb>]  [<ffffffffa02626bb>] write_extent_buffer+0x99/0x10e [btrfs]
[11502.602821] RSP: 0018:ffff88081b3efb08  EFLAGS: 00010202
[11502.602910] RAX: ffff880467a29478 RBX: ffff880467a29260 RCX: 0000000000000000
[11502.603004] RDX: 0000000000000000 RSI: ffff88081b3efb7f RDI: ffff880405927000
[11502.603098] RBP: ffff88081b3efb58 R08: ffff88081b3efb88 R09: ffff88081b3efb80
[11502.603191] R10: 0000000000000ff9 R11: 0000000000000000 R12: 0000000000000001
[11502.603284] R13: 0000000000000008 R14: ffff880000000000 R15: 0000160000000000
[11502.603379] FS:  00007f1555bd6700(0000) GS:ffff88046d800000(0000) knlGS:0000000000000000
[11502.603501] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[11502.603590] CR2: 0000000000000000 CR3: 000000080d209000 CR4: 00000000000007e0
[11502.603684] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[11502.603778] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[11502.603873] Process filebench (pid: 4865, threadinfo ffff88081b3ee000, task ffff88086175cb80)
[11502.604364] Stack:
[11502.604443]  0000000100000001 ffff8804677dc000 ffff880467a29260 ffff88081b3efb7f
[11502.604771]  0000000000000000 ffff88081b3efc68 ffff880467a29260 0000000000000fcc
[11502.605084]  0000000000002000 000000000000002d ffff88081b3efbc8 ffffffffa026003c
[11502.605392] Call Trace:
[11502.605510]  [<ffffffffa026003c>] btrfs_set_token_64+0x9d/0xd3 [btrfs]
[11502.605635]  [<ffffffffa027acdc>] btrfs_log_changed_extents+0x3b5/0x585 [btrfs]
[11502.605759]  [<ffffffff813b3a9f>] ? _raw_spin_unlock+0x26/0x2a
[11502.605881]  [<ffffffffa0264649>] ? release_extent_buffer+0x98/0xa3 [btrfs]
[11502.606007]  [<ffffffffa027dfa7>] btrfs_log_inode+0x4ba/0x5d1 [btrfs]
[11502.606112]  [<ffffffff813b1682>] ? __mutex_lock_common+0x316/0x327
[11502.606236]  [<ffffffffa027e282>] btrfs_log_inode_parent+0x1c4/0x2f1 [btrfs]
[11502.606362]  [<ffffffffa027e443>] btrfs_log_dentry_safe+0x38/0x51 [btrfs]
[11502.606486]  [<ffffffffa025e597>] btrfs_sync_file+0x162/0x1e5 [btrfs]
[11502.606582]  [<ffffffff8114e37d>] vfs_fsync_range+0x18/0x21
[11502.606673]  [<ffffffff8114e39d>] vfs_fsync+0x17/0x19
[11502.606762]  [<ffffffff8114e558>] do_fsync+0x35/0x53
[11502.606852]  [<ffffffff811ef729>] ? lockdep_sys_exit_thunk+0x35/0x67
[11502.606945]  [<ffffffff8114e593>] sys_fsync+0xb/0xf
[11502.607036]  [<ffffffff813ba7a9>] system_call_fastpath+0x16/0x1b
[11502.607125] Code: 81 e1 ff 0f 00 00 49 c1 e5 03 49 bf 00 00 00 00 00 16 00 00 49 be 00 00 00 00 00 88 ff ff eb 6c 48 8b 83 98 02 00 00 4a 8b 14 28 <48> 8b 02 a8 08 74 02 eb 21 be af 12 00 00 48 c7 c7 68 ae 2a a0 
[11502.610492] RIP  [<ffffffffa02626bb>] write_extent_buffer+0x99/0x10e [btrfs]
[11502.610665]  RSP <ffff88081b3efb08>
[11502.610746] CR2: 0000000000000000
[11502.610851] ---[ end trace 568976af2f674cea ]---
[11502.611045] filebench[4864]: segfault at 0 ip 000000000041b881 sp 00007fff753c4eb0 error 4 in filebench[400000+30000]
Comment 1 benlong zhang 2013-06-22 07:49:44 UTC
By the way, the varmail thread number is set to 1.
Comment 2 Josef Bacik 2013-07-02 15:57:06 UTC
Can you reproduce on btrfs-next?
Comment 3 David Sterba 2013-07-03 13:04:35 UTC
(In reply to comment #0)
> When I run filebench varmail test under btrfs of Linux kernel 3.8.2, I got
> this

Can you be more specific how do you run it?

* we know that $nthreads is 1 per comment 1
* what's the run time

* underlying storage
* mkfs options
* mount options

Note You need to log in before you can comment on or make changes to this bug.