Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1758050AbZFPQGR (ORCPT ); Tue, 16 Jun 2009 12:06:17 -0400 Received: (majordomo@vger.kernel.org) by vger.kernel.org id S1752702AbZFPQGI (ORCPT ); Tue, 16 Jun 2009 12:06:08 -0400 Received: from lucidpixels.com ([75.144.35.66]:34646 "EHLO lucidpixels.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752549AbZFPQGH (ORCPT ); Tue, 16 Jun 2009 12:06:07 -0400 Date: Tue, 16 Jun 2009 12:06:08 -0400 (EDT) From: Justin Piszcz To: linux-kernel@vger.kernel.org Subject: 2.6.29.1: nfsd: page allocation failure - nfsd or kernel problem? In-Reply-To: Message-ID: References: User-Agent: Alpine 2.00 (DEB 1167 2008-08-23) MIME-Version: 1.0 Content-Type: TEXT/PLAIN; charset=US-ASCII; format=flowed Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 16092 Lines: 249 Package: nfs-kernel-server Version: 1.1.6-1 Distribution: Debian Testing Architecture: 64-bit [6042655.755870] Pid: 7093, comm: nfsd Not tainted 2.6.29.1 #4 [6042655.755872] Call Trace: [6042655.755874] [] __alloc_pages_internal+0x3dd/0x4e0 [6042655.755885] [] cache_alloc_refill+0x2fb/0x570 [6042655.755887] [] __kmalloc+0xdb/0xe0 [6042655.755891] [] __alloc_skb+0x6d/0x150 [6042655.755893] [] __netdev_alloc_skb+0x17/0x40 [6042655.755897] [] e1000_alloc_rx_buffers+0x23b/0x2c0 [6042655.755899] [] e1000_clean_rx_irq+0x25d/0x3a0 [6042655.755901] [] e1000_clean+0x180/0x2d0 [6042655.755904] [] net_rx_action+0x87/0x130 [6042655.755907] [] __do_softirq+0x93/0x160 [6042655.755910] [] call_softirq+0x1c/0x30 [6042655.755912] [] do_softirq+0x35/0x80 [6042655.755914] [] do_IRQ+0x83/0x110 [6042655.755917] [] ret_from_intr+0x0/0xa [6042655.755918] [] _spin_lock+0x10/0x20 [6042655.755924] [] d_find_alias+0x1c/0x40 [6042655.755926] [] d_obtain_alias+0x4d/0x140 [6042655.755930] [] exportfs_decode_fh+0x63/0x2a0 [6042655.755932] [] nfsd_acceptable+0x0/0x110 [6042655.755935] [] cache_check+0x4a/0x4d0 [6042655.755937] [] exp_find_key+0x57/0xe0 [6042655.755941] [] sock_recvmsg+0xd5/0x110 [6042655.755943] [] exp_find+0x92/0xa0 [6042655.755945] [] fh_verify+0x369/0x680 [6042655.755948] [] check_preempt_wakeup+0xf9/0x120 [6042655.755950] [] nfsd_open+0x2e/0x180 [6042655.755952] [] nfsd_write+0xc4/0x120 [6042655.755955] [] nfsd3_proc_write+0xb0/0x150 [6042655.755957] [] nfsd_dispatch+0xba/0x270 [6042655.755960] [] svc_process+0x49e/0x800 [6042655.755962] [] default_wake_function+0x0/0x10 [6042655.755965] [] __down_read+0x17/0xae [6042655.755966] [] nfsd+0x199/0x2b0 [6042655.755968] [] nfsd+0x0/0x2b0 [6042655.755971] [] kthread+0x47/0x90 [6042655.755973] [] child_rip+0xa/0x20 [6042655.755975] [] kthread+0x0/0x90 [6042655.755977] [] child_rip+0x0/0x20 [6042655.755979] Mem-Info: [6042655.755980] DMA per-cpu: [6042655.755982] CPU 0: hi: 0, btch: 1 usd: 0 [6042655.755983] CPU 1: hi: 0, btch: 1 usd: 0 [6042655.755985] CPU 2: hi: 0, btch: 1 usd: 0 [6042655.755986] CPU 3: hi: 0, btch: 1 usd: 0 [6042655.755987] DMA32 per-cpu: [6042655.755988] CPU 0: hi: 186, btch: 31 usd: 168 [6042655.755990] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.755991] CPU 2: hi: 186, btch: 31 usd: 161 [6042655.755992] CPU 3: hi: 186, btch: 31 usd: 221 [6042655.755993] Normal per-cpu: [6042655.755995] CPU 0: hi: 186, btch: 31 usd: 156 [6042655.755996] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.755997] CPU 2: hi: 186, btch: 31 usd: 187 [6042655.755998] CPU 3: hi: 186, btch: 31 usd: 202 [6042655.756001] Active_anon:108072 active_file:103321 inactive_anon:31621 [6042655.756002] inactive_file:984722 unevictable:0 dirty:71104 writeback:0 unstable:0 [6042655.756003] free:8659 slab:746182 mapped:8842 pagetables:5374 bounce:0 [6042655.756005] DMA free:9736kB min:16kB low:20kB high:24kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB present:8744kB pages_scanned:0 all_unreclaimable? yes [6042655.756008] lowmem_reserve[]: 0 3246 7980 7980 [6042655.756012] DMA32 free:21420kB min:6656kB low:8320kB high:9984kB active_anon:52420kB inactive_anon:38552kB active_file:146252kB inactive_file:1651512kB unevictable:0kB present:3324312kB pages_scanned:0 all_unreclaimable? no [6042655.756014] lowmem_reserve[]: 0 0 4734 4734 [6042655.756018] Normal free:3480kB min:9708kB low:12132kB high:14560kB active_anon:379868kB inactive_anon:87932kB active_file:267032kB inactive_file:2287376kB unevictable:0kB present:4848000kB pages_scanned:0 all_unreclaimable? no [6042655.756020] lowmem_reserve[]: 0 0 0 0 [6042655.756023] DMA: 4*4kB 5*8kB 3*16kB 3*32kB 1*64kB 2*128kB 2*256kB 1*512kB 2*1024kB 1*2048kB 1*4096kB = 9736kB [6042655.756030] DMA32: 3123*4kB 77*8kB 3*16kB 1*32kB 1*64kB 0*128kB 1*256kB 1*512kB 1*1024kB 1*2048kB 1*4096kB = 21188kB [6042655.756036] Normal: 1*4kB 1*8kB 0*16kB 1*32kB 1*64kB 0*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 0*4096kB = 3436kB [6042655.756042] 1090130 total pagecache pages [6042655.756044] 2059 pages in swap cache [6042655.756046] Swap cache stats: add 125946, delete 123887, find 3279355/3285565 [6042655.756047] Free swap = 16734964kB [6042655.756048] Total swap = 16787768kB [6042655.756125] 2277376 pages RAM [6042655.756125] 252195 pages reserved [6042655.756125] 790472 pages shared [6042655.756125] 1269664 pages non-shared [6042655.794633] nfsd: page allocation failure. order:0, mode:0x20 [6042655.794637] Pid: 7093, comm: nfsd Not tainted 2.6.29.1 #4 [6042655.794638] Call Trace: [6042655.794640] [] __alloc_pages_internal+0x3dd/0x4e0 [6042655.794649] [] cache_alloc_refill+0x2fb/0x570 [6042655.794652] [] kmem_cache_alloc+0x95/0xa0 [6042655.794655] [] __alloc_skb+0x49/0x150 [6042655.794658] [] tcp_send_ack+0x26/0x120 [6042655.794660] [] tcp_rcv_established+0x7a2/0x920 [6042655.794663] [] tcp_v4_do_rcv+0xdd/0x210 [6042655.794665] [] tcp_v4_rcv+0x676/0x710 [6042655.794668] [] ip_local_deliver_finish+0x8c/0x160 [6042655.794670] [] ip_rcv_finish+0x191/0x330 [6042655.794672] [] ip_rcv+0x246/0x2e0 [6042655.794676] [] e1000_clean_rx_irq+0x114/0x3a0 [6042655.794678] [] e1000_clean+0x180/0x2d0 [6042655.794681] [] net_rx_action+0x87/0x130 [6042655.794683] [] __do_softirq+0x93/0x160 [6042655.794687] [] call_softirq+0x1c/0x30 [6042655.794689] [] do_softirq+0x35/0x80 [6042655.794691] [] do_IRQ+0x83/0x110 [6042655.794693] [] ret_from_intr+0x0/0xa [6042655.794694] [] _spin_lock+0x10/0x20 [6042655.794700] [] d_find_alias+0x1c/0x40 [6042655.794703] [] d_obtain_alias+0x4d/0x140 [6042655.794706] [] exportfs_decode_fh+0x63/0x2a0 [6042655.794708] [] nfsd_acceptable+0x0/0x110 [6042655.794711] [] cache_check+0x4a/0x4d0 [6042655.794714] [] exp_find_key+0x57/0xe0 [6042655.794717] [] sock_recvmsg+0xd5/0x110 [6042655.794719] [] exp_find+0x92/0xa0 [6042655.794721] [] fh_verify+0x369/0x680 [6042655.794724] [] check_preempt_wakeup+0xf9/0x120 [6042655.794726] [] nfsd_open+0x2e/0x180 [6042655.794728] [] nfsd_write+0xc4/0x120 [6042655.794730] [] nfsd3_proc_write+0xb0/0x150 [6042655.794732] [] nfsd_dispatch+0xba/0x270 [6042655.794736] [] svc_process+0x49e/0x800 [6042655.794738] [] default_wake_function+0x0/0x10 [6042655.794740] [] __down_read+0x17/0xae [6042655.794742] [] nfsd+0x199/0x2b0 [6042655.794743] [] nfsd+0x0/0x2b0 [6042655.794747] [] kthread+0x47/0x90 [6042655.794749] [] child_rip+0xa/0x20 [6042655.794751] [] kthread+0x0/0x90 [6042655.794753] [] child_rip+0x0/0x20 [6042655.794754] Mem-Info: [6042655.794755] DMA per-cpu: [6042655.794757] CPU 0: hi: 0, btch: 1 usd: 0 [6042655.794758] CPU 1: hi: 0, btch: 1 usd: 0 [6042655.794760] CPU 2: hi: 0, btch: 1 usd: 0 [6042655.794761] CPU 3: hi: 0, btch: 1 usd: 0 [6042655.794762] DMA32 per-cpu: [6042655.794763] CPU 0: hi: 186, btch: 31 usd: 168 [6042655.794765] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.794766] CPU 2: hi: 186, btch: 31 usd: 161 [6042655.794767] CPU 3: hi: 186, btch: 31 usd: 221 [6042655.794768] Normal per-cpu: [6042655.794770] CPU 0: hi: 186, btch: 31 usd: 156 [6042655.794771] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.794772] CPU 2: hi: 186, btch: 31 usd: 187 [6042655.794773] CPU 3: hi: 186, btch: 31 usd: 202 [6042655.794776] Active_anon:108072 active_file:103321 inactive_anon:31621 [6042655.794777] inactive_file:984722 unevictable:0 dirty:71104 writeback:0 unstable:0 [6042655.794778] free:8659 slab:746182 mapped:8842 pagetables:5374 bounce:0 [6042655.794780] DMA free:9736kB min:16kB low:20kB high:24kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB present:8744kB pages_scanned:0 all_unreclaimable? yes [6042655.794783] lowmem_reserve[]: 0 3246 7980 7980 [6042655.794787] DMA32 free:21420kB min:6656kB low:8320kB high:9984kB active_anon:52420kB inactive_anon:38552kB active_file:146252kB inactive_file:1651512kB unevictable:0kB present:3324312kB pages_scanned:0 all_unreclaimable? no [6042655.794789] lowmem_reserve[]: 0 0 4734 4734 [6042655.794793] Normal free:3480kB min:9708kB low:12132kB high:14560kB active_anon:379868kB inactive_anon:87932kB active_file:267032kB inactive_file:2287376kB unevictable:0kB present:4848000kB pages_scanned:0 all_unreclaimable? no [6042655.794795] lowmem_reserve[]: 0 0 0 0 [6042655.794798] DMA: 4*4kB 5*8kB 3*16kB 3*32kB 1*64kB 2*128kB 2*256kB 1*512kB 2*1024kB 1*2048kB 1*4096kB = 9736kB [6042655.794805] DMA32: 3123*4kB 77*8kB 3*16kB 1*32kB 1*64kB 0*128kB 1*256kB 1*512kB 1*1024kB 1*2048kB 1*4096kB = 21188kB [6042655.794811] Normal: 1*4kB 1*8kB 0*16kB 1*32kB 1*64kB 0*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 0*4096kB = 3436kB [6042655.794818] 1090130 total pagecache pages [6042655.794819] 2059 pages in swap cache [6042655.794821] Swap cache stats: add 125946, delete 123887, find 3279355/3285565 [6042655.794822] Free swap = 16734964kB [6042655.794823] Total swap = 16787768kB [6042655.795578] 2277376 pages RAM [6042655.795578] 252195 pages reserved [6042655.795578] 790472 pages shared [6042655.795578] 1269664 pages non-shared [6042655.828540] nfsd: page allocation failure. order:0, mode:0x20 [6042655.828544] Pid: 7093, comm: nfsd Not tainted 2.6.29.1 #4 [6042655.828545] Call Trace: [6042655.828547] [] __alloc_pages_internal+0x3dd/0x4e0 [6042655.828555] [] cache_alloc_refill+0x2fb/0x570 [6042655.828557] [] kmem_cache_alloc+0x95/0xa0 [6042655.828561] [] __alloc_skb+0x49/0x150 [6042655.828564] [] __netdev_alloc_skb+0x17/0x40 [6042655.828567] [] e1000_alloc_rx_buffers+0x23b/0x2c0 [6042655.828570] [] e1000_clean_rx_irq+0x25d/0x3a0 [6042655.828572] [] e1000_clean+0x180/0x2d0 [6042655.828574] [] net_rx_action+0x87/0x130 [6042655.828578] [] __do_softirq+0x93/0x160 [6042655.828581] [] call_softirq+0x1c/0x30 [6042655.828583] [] do_softirq+0x35/0x80 [6042655.828585] [] do_IRQ+0x83/0x110 [6042655.828587] [] ret_from_intr+0x0/0xa [6042655.828589] [] _spin_lock+0x10/0x20 [6042655.828595] [] d_find_alias+0x1c/0x40 [6042655.828598] [] d_obtain_alias+0x4d/0x140 [6042655.828601] [] exportfs_decode_fh+0x63/0x2a0 [6042655.828604] [] nfsd_acceptable+0x0/0x110 [6042655.828606] [] cache_check+0x4a/0x4d0 [6042655.828609] [] exp_find_key+0x57/0xe0 [6042655.828612] [] sock_recvmsg+0xd5/0x110 [6042655.828614] [] exp_find+0x92/0xa0 [6042655.828616] [] fh_verify+0x369/0x680 [6042655.828619] [] check_preempt_wakeup+0xf9/0x120 [6042655.828622] [] nfsd_open+0x2e/0x180 [6042655.828623] [] nfsd_write+0xc4/0x120 [6042655.828626] [] nfsd3_proc_write+0xb0/0x150 [6042655.828628] [] nfsd_dispatch+0xba/0x270 [6042655.828631] [] svc_process+0x49e/0x800 [6042655.828634] [] default_wake_function+0x0/0x10 [6042655.828636] [] __down_read+0x17/0xae [6042655.828638] [] nfsd+0x199/0x2b0 [6042655.828639] [] nfsd+0x0/0x2b0 [6042655.828643] [] kthread+0x47/0x90 [6042655.828645] [] child_rip+0xa/0x20 [6042655.828647] [] kthread+0x0/0x90 [6042655.828649] [] child_rip+0x0/0x20 [6042655.828650] Mem-Info: [6042655.828651] DMA per-cpu: [6042655.828653] CPU 0: hi: 0, btch: 1 usd: 0 [6042655.828655] CPU 1: hi: 0, btch: 1 usd: 0 [6042655.828656] CPU 2: hi: 0, btch: 1 usd: 0 [6042655.828657] CPU 3: hi: 0, btch: 1 usd: 0 [6042655.828658] DMA32 per-cpu: [6042655.828659] CPU 0: hi: 186, btch: 31 usd: 168 [6042655.828661] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.828662] CPU 2: hi: 186, btch: 31 usd: 161 [6042655.828663] CPU 3: hi: 186, btch: 31 usd: 221 [6042655.828665] Normal per-cpu: [6042655.828666] CPU 0: hi: 186, btch: 31 usd: 156 [6042655.828667] CPU 1: hi: 186, btch: 31 usd: 30 [6042655.828668] CPU 2: hi: 186, btch: 31 usd: 187 [6042655.828670] CPU 3: hi: 186, btch: 31 usd: 202 [6042655.828672] Active_anon:108072 active_file:103321 inactive_anon:31621 [6042655.828673] inactive_file:984722 unevictable:0 dirty:71104 writeback:0 unstable:0 [6042655.828674] free:8659 slab:746182 mapped:8842 pagetables:5374 bounce:0 [6042655.828677] DMA free:9736kB min:16kB low:20kB high:24kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB present:8744kB pages_scanned:0 all_unreclaimable? yes [6042655.828679] lowmem_reserve[]: 0 3246 7980 7980 [6042655.828683] DMA32 free:21420kB min:6656kB low:8320kB high:9984kB active_anon:52420kB inactive_anon:38552kB active_file:146252kB inactive_file:1651512kB unevictable:0kB present:3324312kB pages_scanned:0 all_unreclaimable? no [6042655.828685] lowmem_reserve[]: 0 0 4734 4734 [6042655.828689] Normal free:3480kB min:9708kB low:12132kB high:14560kB active_anon:379868kB inactive_anon:87932kB active_file:267032kB inactive_file:2287376kB unevictable:0kB present:4848000kB pages_scanned:0 all_unreclaimable? no [6042655.828692] lowmem_reserve[]: 0 0 0 0 [6042655.828694] DMA: 4*4kB 5*8kB 3*16kB 3*32kB 1*64kB 2*128kB 2*256kB 1*512kB 2*1024kB 1*2048kB 1*4096kB = 9736kB [6042655.828701] DMA32: 3123*4kB 77*8kB 3*16kB 1*32kB 1*64kB 0*128kB 1*256kB 1*512kB 1*1024kB 1*2048kB 1*4096kB = 21188kB [6042655.828707] Normal: 1*4kB 1*8kB 0*16kB 1*32kB 1*64kB 0*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 0*4096kB = 3436kB [6042655.828714] 1090130 total pagecache pages [6042655.828715] 2059 pages in swap cache [6042655.828717] Swap cache stats: add 125946, delete 123887, find 3279355/3285565 [6042655.828718] Free swap = 16734964kB [6042655.828719] Total swap = 16787768kB [6042655.830324] 2277376 pages RAM [6042655.830324] 252195 pages reserved [6042655.830324] 790472 pages shared [6042655.830324] 1269089 pages non-shared -- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.kernel.org More majordomo info at http://vger.kernel.org/majordomo-info.html Please read the FAQ at http://www.tux.org/lkml/