kernel panic 2.6.31-16-generic nfs "BUG: unable to handle kernel paging request"

[lak]

Copying a device over NFS results in the below kernel panic. Roughly 350/500 gb were successfully copied before the panic. I have hit this bug twice now in an attempt to copy the device.

ddrescue /dev/sda /nfs/media

Linux lexus 2.6.31-16-generic #53-Ubuntu SMP Tue Dec 8 04:02:15 UTC 2009 x86_64 GNU/Linux
Ubuntu 2.6.31-16.53-generic
Description: Ubuntu 9.10
Release: 9.10

nfs-common:
  Installed: 1:1.2.0-2ubuntu8
  Candidate: 1:1.2.0-2ubuntu8
  Version table:
 *** 1:1.2.0-2ubuntu8 0
        500 http://us.archive.ubuntu.com karmic/main Packages
        100 /var/lib/dpkg/status

Dec 15 15:56:34 lexus kernel: [35009.678488] BUG: unable to handle kernel paging request at ffff8800e59bdf10
Dec 15 15:56:34 lexus kernel: [35009.678504] IP: [<ffffffffa0befa88>] nfs_set_page_tag_locked+0x8/0x40 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678560] PGD 1002063 PUD 12067 PMD 0
Dec 15 15:56:34 lexus kernel: [35009.678568] Oops: 0000 [#1] SMP
Dec 15 15:56:34 lexus kernel: [35009.678574] last sysfs file: /sys/devices/virtual/block/ram9/uevent
Dec 15 15:56:34 lexus kernel: [35009.678582] CPU 1
Dec 15 15:56:34 lexus kernel: [35009.678586] Modules linked in: binfmt_misc ppdev nfs lockd nfs_acl auth_rpcgss sunrpc snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device snd soundcore iptable_filter hwmon_vid i2c_nforce2 ip_tables amd64_edac_mod snd_page_alloc nvidia(P) k8temp edac_core serio_raw x_tables lp parport usbhid ohci1394 ieee1394 forcedeth
Dec 15 15:56:34 lexus kernel: [35009.678650] Pid: 9795, comm: nautilus Tainted: P 2.6.31-16-generic #53-Ubuntu Unknow
Dec 15 15:56:34 lexus kernel: [35009.678657] RIP: 0010:[<ffffffffa0befa88>] [<ffffffffa0befa88>] nfs_set_page_tag_locked+0x8/0x40 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678687] RSP: 0018:ffff880001ac5b28 EFLAGS: 00010286
Dec 15 15:56:34 lexus kernel: [35009.678692] RAX: ffff8800e59bdf00 RBX: ffff8800c07de600 RCX: 0000000000000001
Dec 15 15:56:34 lexus kernel: [35009.678697] RDX: 0000000000000001 RSI: ffffea000082e5a8 RDI: ffff8800c07de600
Dec 15 15:56:34 lexus kernel: [35009.678702] RBP: ffff880001ac5b28 R08: 0000000000000018 R09: 0000000000000000
Dec 15 15:56:34 lexus kernel: [35009.678707] R10: a040000000000000 R11: ffff8800bad448a8 R12: ffff8800c4c2eda0
Dec 15 15:56:34 lexus kernel: [35009.678712] R13: ffffea000082e5a8 R14: ffff880001ac5cf8 R15: ffff880001ac5c70
Dec 15 15:56:34 lexus kernel: [35009.678719] FS: 00007f7e7c768910(0000) GS:ffff88002803d000(0000) knlGS:00000000f6a36750
Dec 15 15:56:34 lexus kernel: [35009.678725] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
Dec 15 15:56:34 lexus kernel: [35009.678729] CR2: ffff8800e59bdf10 CR3: 00000000ca0ba000 CR4: 00000000000006e0
Dec 15 15:56:34 lexus kernel: [35009.678735] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Dec 15 15:56:34 lexus kernel: [35009.678740] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Dec 15 15:56:34 lexus kernel: [35009.678746] Process nautilus (pid: 9795, threadinfo ffff880001ac4000, task ffff880085172d60)
Dec 15 15:56:34 lexus kernel: [35009.678750] Stack:
Dec 15 15:56:34 lexus kernel: [35009.678753] ffff880001ac5b68 ffffffffa0bf3878 ffff880037a14848 ffffea000082e5a8
Dec 15 15:56:34 lexus kernel: [35009.678761] <0> ffff880001ac5cf8 ffffea000082e5a8 0000000000000008 ffff880001ac5c70
Dec 15 15:56:34 lexus kernel: [35009.678769] <0> ffff880001ac5b88 ffffffffa0bf3a02 ffffea000082e5a8 ffff8800c4c2ee08
Dec 15 15:56:34 lexus kernel: [35009.678779] Call Trace:
Dec 15 15:56:34 lexus kernel: [35009.678808] [<ffffffffa0bf3878>] nfs_page_async_flush+0x38/0x140 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678835] [<ffffffffa0bf3a02>] nfs_do_writepage+0x82/0x90 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678861] [<ffffffffa0bf4129>] nfs_writepages_callback+0x19/0x40 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678875] [<ffffffff810e35e9>] write_cache_pages+0x1f9/0x4e0
Dec 15 15:56:34 lexus kernel: [35009.678904] [<ffffffffa0bf4110>] ? nfs_writepages_callback+0x0/0x40 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678932] [<ffffffffa0bf4094>] nfs_writepages+0xb4/0x130 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678959] [<ffffffffa0bf4380>] ? nfs_flush_one+0x0/0xf0 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.678986] [<ffffffffa0bf5166>] nfs_write_mapping+0x66/0xb0 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.679013] [<ffffffffa0bf51c5>] nfs_wb_nocommit+0x15/0x20 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.679038] [<ffffffffa0be7ce0>] nfs_getattr+0x120/0x130 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.679047] [<ffffffff8127c31d>] ? copy_user_generic_string+0x2d/0x40
Dec 15 15:56:34 lexus kernel: [35009.679056] [<ffffffff81123709>] vfs_getattr+0x49/0x80
Dec 15 15:56:34 lexus kernel: [35009.679062] [<ffffffff81123798>] vfs_fstatat+0x58/0x70
Dec 15 15:56:34 lexus kernel: [35009.679069] [<ffffffff81123819>] vfs_lstat+0x19/0x20
Dec 15 15:56:34 lexus kernel: [35009.679075] [<ffffffff8112383f>] sys_newlstat+0x1f/0x50
Dec 15 15:56:34 lexus kernel: [35009.679086] [<ffffffff8152a289>] ? do_device_not_available+0x9/0x10
Dec 15 15:56:34 lexus kernel: [35009.679094] [<ffffffff81012e9b>] ? device_not_available+0x1b/0x20
Dec 15 15:56:34 lexus kernel: [35009.679104] [<ffffffff81012002>] system_call_fastpath+0x16/0x1b
Dec 15 15:56:34 lexus kernel: [35009.679108] Code: 5f b4 03 00 48 89 de e8 07 4b 52 e0 48 8b 1c 24 4c 8b 64 24 08 c9 c3 66 66 66 2e 0f 1f 84 00 00 00 00 00 55 48 8b 47 18 48 89 e5 <48> 8b 40 10 48 8b 48 10 f0 0f ba 6f 40 00 19 d2 31 c0 85 d2 75
Dec 15 15:56:34 lexus kernel: [35009.679169] RIP [<ffffffffa0befa88>] nfs_set_page_tag_locked+0x8/0x40 [nfs]
Dec 15 15:56:34 lexus kernel: [35009.679197] RSP <ffff880001ac5b28>
Dec 15 15:56:34 lexus kernel: [35009.679200] CR2: ffff8800e59bdf10
Dec 15 15:56:34 lexus kernel: [35009.679206] ---[ end trace 0105ad4a64ac8c4a ]---
Dec 15 15:57:39 lexus kernel: [35074.852488] BUG: soft lockup - CPU#1 stuck for 61s! [rpciod/1:1689]
Dec 15 15:57:39 lexus kernel: [35074.852492] Modules linked in: binfmt_misc ppdev nfs lockd nfs_acl auth_rpcgss sunrpc snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_devic
e snd soundcore iptable_filter hwmon_vid i2c_nforce2 ip_tables amd64_edac_mod snd_page_alloc nvidia(P) k8temp edac_core serio_raw x_tables lp parport usbhid ohci1394 ieee1394 forcedeth
Dec 15 15:57:39 lexus kernel: [35074.852507] CPU 1:
Dec 15 15:57:39 lexus kernel: [35074.852507] Modules linked in: binfmt_misc ppdev nfs lockd nfs_acl auth_rpcgss sunrpc snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device snd soundcore iptable_filter hwmon_vid i2c_nforce2 ip_tables amd64_edac_mod snd_page_alloc nvidia(P) k8temp edac_core serio_raw x_tables lp parport usbhid ohci1394 ieee1394 forcedeth
Dec 15 15:57:39 lexus kernel: [35074.852507] Pid: 1689, comm: rpciod/1 Tainted: P D 2.6.31-16-generic #53-Ubuntu Unknow
Dec 15 15:57:39 lexus kernel: [35074.852507] RIP: 0010:[<ffffffff81036392>] [<ffffffff81036392>] __ticket_spin_lock+0x12/0x20
Dec 15 15:57:39 lexus kernel: [35074.852507] RSP: 0018:ffff8800d53ddd20 EFLAGS: 00000297
Dec 15 15:57:39 lexus kernel: [35074.852507] RAX: 0000000000008b8a RBX: ffff8800d53ddd20 RCX: 000000004899254b
Dec 15 15:57:39 lexus kernel: [35074.852507] RDX: 0000000000040000 RSI: ffff8800a30f4720 RDI: ffff8800c4c2eda0
Dec 15 15:57:39 lexus kernel: [35074.852507] RBP: ffffffff81012bae R08: 0000000000000000 R09: 0000000000000000
Dec 15 15:57:39 lexus kernel: [35074.852507] R10: 0000000000000001 R11: 00000000ffffffff R12: ffff8800d88a39c0
Dec 15 15:57:39 lexus kernel: [35074.852507] R13: 0000000000004000 R14: ffff8800dedd9380 R15: ffffffff8142999a
Dec 15 15:57:39 lexus kernel: [35074.852507] FS: 00007f8c66fe46f0(0000) GS:ffff88002803d000(0000) knlGS:00000000f6a36750
Dec 15 15:57:39 lexus kernel: [35074.852507] CS: 0010 DS: 0018 ES: 0018 CR0: 000000008005003b
Dec 15 15:57:39 lexus kernel: [35074.852507] CR2: ffff8800e59bdf10 CR3: 0000000001001000 CR4: 00000000000006e0
Dec 15 15:57:39 lexus kernel: [35074.852507] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Dec 15 15:57:39 lexus kernel: [35074.852507] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Dec 15 15:57:39 lexus kernel: [35074.852507] Call Trace:
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff81529a49>] ? _spin_lock+0x9/0x10
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0be7220>] ? nfs_post_op_update_inode_force_wcc+0x30/0x240 [nfs]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0bf658c>] ? nfs3_write_done+0x4c/0x60 [nfs]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0bf3c3c>] ? nfs_writeback_done+0x5c/0x250 [nfs]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0bf3e39>] ? nfs_writeback_done_full+0x9/0x10 [nfs]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0b965d7>] ? rpc_exit_task+0x27/0x60 [sunrpc]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0b96e4a>] ? __rpc_execute+0xba/0x220 [sunrpc]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0b96fe0>] ? rpc_async_schedule+0x0/0x20 [sunrpc]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffffa0b96ff0>] ? rpc_async_schedule+0x10/0x20 [sunrpc]
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff810737a5>] ? run_workqueue+0x95/0x170
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff81073924>] ? worker_thread+0xa4/0x120
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff81078b30>] ? autoremove_wake_function+0x0/0x40
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff81073880>] ? worker_thread+0x0/0x120
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff81078746>] ? kthread+0xa6/0xb0
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff810130ea>] ? child_rip+0xa/0x20
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff810786a0>] ? kthread+0x0/0xb0
Dec 15 15:57:39 lexus kernel: [35074.852507] [<ffffffff810130e0>] ? child_rip+0x0/0x20

[Lou (louc)]

Using Virtual Box v 3.1.4.57640. Will only run in low graphics mode even after reinstalling guest additions. will only run in 800x600. Under previous kernel 1280x800.

[Jeremy Foshee (jeremyfoshee)]

Hi lak,

This bug was reported a while ago and there hasn't been any activity in it recently. We were wondering if this is still an issue? Can you try with the latest development release of Ubuntu? ISO CD images are available from http://cdimage.ubuntu.com/releases/ .

If it remains an issue, could you run the following command from a Terminal (Applications->Accessories->Terminal). It will automatically gather and attach updated debug information to this report.

apport-collect -p linux 497269

Also, if you could test the latest upstream kernel available that would be great. It will allow additional upstream developers to examine the issue. Refer to https://wiki.ubuntu.com/KernelMainlineBuilds . Once you've tested the upstream kernel, please remove the 'needs-upstream-testing' tag. This can be done by clicking on the yellow pencil icon next to the tag located at the bottom of the bug description and deleting the 'needs-upstream-testing' text. Please let us know your results.

Thanks in advance.

    [This is an automated message. Apologies if it has reached you inappropriately; please just reply to this message indicating so.]

[Jeremy Foshee (jeremyfoshee)]

This bug report was marked as Incomplete and has not had any updated comments for quite some time. As a result this bug is being closed. Please reopen if this is still an issue in the current Ubuntu release http://www.ubuntu.com/getubuntu/download . Also, please be sure to provide any requested information that may have been missing. To reopen the bug, click on the current status under the Status column and change the status back to "New". Thanks.

[This is an automated message. Apologies if it has reached you inappropriately; please just reply to this message indicating so.]