lkml.org 
[lkml]   [2010]   [Dec]   [1]   [last100]   RSS Feed
Views: [wrap][no wrap]   [headers]  [forward] 
 
Messages in this thread
/
Date
From
SubjectRe: kernel BUG at mm/truncate.c:475!
On Wed, 01 Dec 2010 11:25:22 +0100
Miklos Szeredi <miklos@szeredi.hu> wrote:

> On Tue, 30 Nov 2010, Hugh Dickins wrote:
> > On Tue, 30 Nov 2010, Michael Leun wrote:
> >
> > > happenes sporadically, cannot reproduce at will.
> > >
> > >
> > > Nov 30 15:24:55 elektra kernel: [ 6604.258610] ------------[ cut
> > > here ]------------ Nov 30 15:24:55 elektra kernel: [ 6604.258628]
> > > kernel BUG at mm/truncate.c:475! Nov 30 15:24:55 elektra kernel:
> > > [ 6604.258633] invalid opcode: 0000 [#1] PREEMPT SMP Nov 30
> > > 15:24:55 elektra kernel: [ 6604.258640] last sysfs
> > > file: /sys/devices/system/cpu/cpu3/cache/index2/shared_cpu_map
> > > Nov 30 15:24:55 elektra kernel: [ 6604.258646] CPU 3 Nov 30
> > > 15:24:55 elektra kernel: [ 6604.258649] Modules linked in: veth
> > > fuse af_packet bridge 8021q garp stp llc vboxnetadp vboxnetflt
> > > vboxdrv nouveau ttm drm_kms_helper drm i2c_algo_bit snd_pcm_oss
> > > snd_mixer_oss snd_seq snd_seq_device edd cpufreq_conservative
> > > cpufreq_userspace cpufreq_powersave acpi_cpufreq mperf
> > > ip6t_REJECT ipt_REJECT ip6t_LOG ipt_LOG xt_limit xt_recent
> > > nf_conntrack_ipv6 xt_state xt_tcpudp ip6table_mangle
> > > iptable_mangle iptable_nat ip6table_filter ip6_tables
> > > iptable_filter nf_nat_ftp nf_nat nf_conntrack_ipv4 nf_defrag_ipv4
> > > nf_conntrack_ftp nf_conntrack ip_tables x_tables nls_utf8 loop
> > > arc4 ecb snd_hda_codec_nvhdmi iwlagn iwlcore snd_hda_codec_idt
> > > snd_hda_intel snd_hda_codec snd_hwdep mac80211 snd_pcm ohci1394
> > > ieee1394 cfg80211 snd_timer sdhci_pci snd sdhci pcmcia
> > > firewire_ohci e1000e mmc_core yenta_socket soundcore
> > > firewire_core pcmcia_rsrc crc_itu_t pcmcia_core ppdev mcs7830
> > > dm9601 dell_laptop usbnet rfkill snd_page_alloc dell_wmi shpchp
> > > sr_mod parport_p!
> > c !
> > > sg cdrom wmi dcdbas intel_ips parport i
> > > Nov 30 15:24:55 elektra kernel: ntel_agp i2c_i801 pci_hotplug
> > > iTCO_wdt pcspkr iTCO_vendor_support button video battery ac ext4
> > > jbd2 crc16 sha256_generic aesni_intel cryptd aes_x86_64
> > > aes_generic cbc dm_crypt usbhid linear ehci_hcd usbcore sd_mod
> > > dm_snapshot dm_mod fan processor ahci libahci libata scsi_mod
> > > thermal thermal_sys Nov 30 15:24:55 elektra kernel:
> > > [ 6604.258914] Nov 30 15:24:55 elektra kernel: [ 6604.258918]
> > > Pid: 31399, comm: cut Not tainted 2.6.36.1 #2 0N5KHN/Latitude
> > > E6510 Nov 30 15:24:55 elektra kernel: [ 6604.258924] RIP:
> > > 0010:[<ffffffff810ee5e1>] [<ffffffff810ee5e1>]
> > > invalidate_inode_pages2_range+0x271/0x350 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.258939] RSP: 0018:ffff8800774d5b58 EFLAGS:
> > > 00010246 Nov 30 15:24:55 elektra kernel: [ 6604.258944] RAX:
> > > 0000000000000000 RBX: ffffea0001ea2f40 RCX: ffff8800c05a5bd0 Nov
> > > 30 15:24:55 elektra kernel: [ 6604.258950] RDX: 0000000000000000
> > > RSI: ffff8800774d5a28 RDI: ffff8800c0521a18 Nov 30 15:24:55
> > > elektra kernel: [ 6604.258956] RBP: ffff8800774d5c38 R08:
> > > ffff8800c05a5bd0 R09: ffff8800774d5ae8 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.258962] R10: 0000000000000008 R11:
> > > 0000000000000001 R12: ffff8800774d5b98 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.258969] R13: 0000000000000000 R14:
> > > ffff8800c05219d8 R15: 0000000000000000 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.258980] FS: 0000000000000000(0000)
> > > GS:ffff880001cc0000(0000) knlGS:0000000000000000 Nov 30 15:24:55
> > > elektra kernel: [ 6604.258992] CS: 0010 DS: 0000 ES: 0000 CR0:
> > > 000000008005003b Nov 30 15:24:55 elektra kernel: [ 6604.258999]
> > > CR2: 00007f3ad2337290 CR3: 00000000850b3000 CR4: 00000000000006e0
> > > Nov 30 15:24:55 elektra kernel: [ 6604.259010] DR0:
> > > 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 Nov
> > > 30 15:24:55 elektra kernel: [ 6604.259019] DR3: 0000000000000000
> > > DR6: 00000000ffff0ff0 DR7: 0000000000000400 Nov 30 15:24:55
> > > elektra kernel: [ 6604.259028] Process cut (pid: 31399,
> > > threadinfo ffff8800774d4000, task ffff8800a2bbae40) Nov 30
> > > 15:24:55 elektra kernel: [ 6604.259038] Stack: Nov 30 15:24:55
> > > elektra kernel: [ 6604.259042] ffffffff81074300 ffff8800c05219f0
> > > 00000001774d5b60 0000000000000001 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259054] <0> ffffffffffffffff 00000000c41fec70
> > > 000000000000000e 0000000000000000 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259069] <0> ffffea0001ea2f40 ffffea0001a246c8
> > > ffffea0001a24690 ffffea0001a47348 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259087] Call Trace: Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259094] [<ffffffff81074300>] ?
> > > autoremove_wake_function+0x0/0x40 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259101] [<ffffffff810ee6d2>]
> > > invalidate_inode_pages2+0x12/0x20 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259111] [<ffffffffa0848ce0>] fuse_finish_open+0x60/0x70
> > > [fuse] Nov 30 15:24:55 elektra kernel: [ 6604.259118]
> > > [<ffffffffa0848d71>] fuse_open_common+0x81/0x90 [fuse] Nov 30
> > > 15:24:55 elektra kernel: [ 6604.259125] [<ffffffffa0848d80>] ?
> > > fuse_open+0x0/0x10 [fuse] Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259132] [<ffffffffa0848d8b>] fuse_open+0xb/0x10 [fuse]
> > > Nov 30 15:24:55 elektra kernel: [ 6604.259139]
> > > [<ffffffff81137a1a>] __dentry_open+0x11a/0x3c0 Nov 30 15:24:55
> > > elektra kernel: [ 6604.259147] [<ffffffff811efbda>] ?
> > > security_inode_permission+0x1a/0x20 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.259154] [<ffffffff81138cc4>]
> > > nameidata_to_filp+0x54/0x70 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259160] [<ffffffff81147168>] do_last+0x488/0x760 Nov 30
> > > 15:24:55 elektra kernel: [ 6604.259166] [<ffffffff81147868>]
> > > do_filp_open+0x428/0x670 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259173] [<ffffffffa0842983>] ?
> > > fuse_request_free+0x13/0x20 [fuse] Nov 30 15:24:55 elektra
> > > kernel: [ 6604.259181] [<ffffffffa0842a48>] ?
> > > fuse_put_request+0xb8/0xc0 [fuse] Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259193] [<ffffffff81138d40>] do_sys_open+0x60/0x120 Nov
> > > 30 15:24:55 elektra kernel: [ 6604.259205] [<ffffffff81138e1b>]
> > > sys_open+0x1b/0x20 Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259217] [<ffffffff81002f02>]
> > > system_call_fastpath+0x16/0x1b Nov 30 15:24:55 elektra kernel:
> > > [ 6604.259228] Code: fe ff ff 0f 1f 80 00 00 00 00 48 89 c6 31 c9
> > > 48 c1 e6 0c ba 00 10 00 00 4c 89 f7 e8 ba 37 01 00 8b 43 0c 85 c0
> > > 0f 88 2e ff ff ff <0f> 0b 0f 1f 44 00 00 48 89 df e8 30 39 ff ff
> > > 8b 85 50 ff ff ff Nov 30 15:24:55 elektra kernel: [ 6604.259394]
> > > RIP [<ffffffff810ee5e1>]
> > > invalidate_inode_pages2_range+0x271/0x350 Nov 30 15:24:55 elektra
> > > kernel: [ 6604.259412] RSP <ffff8800774d5b58> Nov 30 15:24:55
> > > elektra kernel: [ 6604.265642] ---[ end trace
> > > 019ef068b5f8e921 ]---
> >
> > BUG_ON(page_mapped(page)) in invalidate_inode_pages2_range():
> > that's interesting, it may relate to another
> > BUG_ON(page_mapped(page)) that's been reported recently.
> >
> > This is a 2.6.36.1 kernel you're running: any idea what was the
> > first kernel on which you started seeing such errors? and what was
> > the last good kernel on which you ran the same kind of load but saw
> > no problems?
>
> The fault handler unlocks the page if vm_ops->page_mkwrite() is
> defined. That looks somewhat racy at first glance.
>
> Quick test: does removing the page_mkwrite() callback from fuse make
> the problem go away?
>
> diff --git a/fs/fuse/file.c b/fs/fuse/file.c
> index c822458..a445358 100644
> --- a/fs/fuse/file.c
> +++ b/fs/fuse/file.c
> @@ -1328,7 +1328,6 @@ static int fuse_page_mkwrite(struct
> vm_area_struct *vma, struct vm_fault *vmf) static const struct
> vm_operations_struct fuse_file_vm_ops = { .close =
> fuse_vma_close, .fault = filemap_fault,
> - .page_mkwrite = fuse_page_mkwrite,
> };
>
> static int fuse_file_mmap(struct file *file, struct vm_area_struct
> *vma)
>
> Thanks,
> Miklos
>

At the moment I've downgraded to 2.6.36 - I cannot remember to have
seen this there - which does not need to mean anything, because
workload has changed (several unshared mount/network namespaces chrooted
into unionfs-fuse mounted roots - cool stuff...).

Would you suspect to make 2.6.36 <> 2.6.36.1 a difference here?

Later, when I've results from the test with 2.6.36 of course I'll try
the quick test you suggested.

--
MfG,

Michael Leun



\
 
 \ /
  Last update: 2010-12-01 12:51    [W:1.029 / U:0.128 seconds]
©2003-2020 Jasper Spaans|hosted at Digital Ocean and TransIP|Read the blog|Advertise on this site