Bug#666021: swapper/2: page allocation failure: order:1, mode:0x20
found 666021 3.2.18-1
tags 666021 +confirmed
thanks
Linux version 3.2.0-2-powerpc64 (Debian 3.2.18-1)
(debian-kernel@lists.debian.org) (gcc version 4.6.3 (Debian 4.6.3-4) )
#1 SMP Mon May 21 22:39:59 UTC 2012
While running debmirror I'm getting call trace every few minutes. Call
trace is attached. The problem completely disappears after issuing:
sysctl vm.min_free_kbytes=16384
The machine is 2.5GHz Quad PowerMac with 4GB of memory. Processes are
using about 260MB while the rest gets used by buffers and cache. Free
memory was floating around 10MB when vm.min_free_kbytes was at 8107 and
is floating around 20MB after I increased the vm.min_free_kbytes to 16384.
M
Jun 6 21:53:39 power kernel: [17882.998757] swapper/2: page allocation failure: order:1, mode:0x20
Jun 6 21:53:39 power kernel: [17883.000968] Call Trace:
Jun 6 21:53:39 power kernel: [17883.002424] [c00000000ffe6d10] [c00000000001350c] .show_stack+0x80/0x130 (unreliable)
Jun 6 21:53:39 power kernel: [17883.003976] [c00000000ffe6dc0] [c000000000119118] .warn_alloc_failed+0xf0/0x108
Jun 6 21:53:39 power kernel: [17883.005544] [c00000000ffe6e80] [c00000000011c3ec] .__alloc_pages_nodemask+0x700/0x7c4
Jun 6 21:53:39 power kernel: [17883.007152] [c00000000ffe7010] [c0000000001589d8] .kmem_getpages+0x5c/0x140
Jun 6 21:53:39 power kernel: [17883.008774] [c00000000ffe70b0] [c000000000158cfc] .fallback_alloc+0x174/0x200
Jun 6 21:53:39 power kernel: [17883.010420] [c00000000ffe7190] [c00000000015a6fc] .kmem_cache_alloc+0x104/0x1f8
Jun 6 21:53:39 power kernel: [17883.012088] [c00000000ffe7250] [c0000000003c3118] .sk_prot_alloc+0x38/0x1c4
Jun 6 21:53:39 power kernel: [17883.013769] [c00000000ffe7300] [c0000000003c41b4] .sk_clone+0x20/0x2cc
Jun 6 21:53:39 power kernel: [17883.015484] [c00000000ffe73a0] [c000000000413378] .inet_csk_clone+0x1c/0x94
Jun 6 21:53:39 power kernel: [17883.017209] [c00000000ffe7430] [c00000000042c324] .tcp_create_openreq_child+0x24/0x3e8
Jun 6 21:53:39 power kernel: [17883.018998] [c00000000ffe74e0] [c00000000042a854] .tcp_v4_syn_recv_sock+0x3c/0x31c
Jun 6 21:53:39 power kernel: [17883.020792] [c00000000ffe7580] [c00000000042c12c] .tcp_check_req+0x350/0x524
Jun 6 21:53:39 power kernel: [17883.022605] [c00000000ffe7670] [c00000000042966c] .tcp_v4_do_rcv+0x200/0x3c8
Jun 6 21:53:39 power kernel: [17883.024427] [c00000000ffe7750] [c00000000042b728] .tcp_v4_rcv+0x558/0x940
Jun 6 21:53:39 power kernel: [17883.026246] [c00000000ffe7840] [c0000000004088f4] .ip_local_deliver_finish+0x1d0/0x2d8
Jun 6 21:53:39 power kernel: [17883.028118] [c00000000ffe78e0] [c000000000408704] .ip_rcv_finish+0x374/0x394
Jun 6 21:53:39 power kernel: [17883.030011] [c00000000ffe7970] [c0000000003d1060] .__netif_receive_skb+0x698/0x6e8
Jun 6 21:53:39 power kernel: [17883.031920] [c00000000ffe7a60] [c0000000003d26c4] .netif_receive_skb+0x90/0x98
Jun 6 21:53:39 power kernel: [17883.033859] [c00000000ffe7b00] [c0000000003d51c0] .napi_skb_finish+0x34/0x58
Jun 6 21:53:39 power kernel: [17883.035857] [c00000000ffe7b80] [d00000000108d4f4] .tg3_poll_work+0x6d8/0xcbc [tg3]
Jun 6 21:53:39 power kernel: [17883.037851] [c00000000ffe7cd0] [d000000001093b24] .tg3_poll+0x258/0x448 [tg3]
Jun 6 21:53:39 power kernel: [17883.039854] [c00000000ffe7dc0] [c0000000003d2924] .net_rx_action+0xd0/0x30c
Jun 6 21:53:39 power kernel: [17883.041893] [c00000000ffe7eb0] [c00000000008b9ac] .__do_softirq+0x158/0x2a0
Jun 6 21:53:39 power kernel: [17883.043979] [c00000000ffe7f90] [c00000000001c68c] .call_do_softirq+0x14/0x24
Jun 6 21:53:39 power kernel: [17883.046089] [c00000017a84f990] [c00000000000edb8] .do_softirq+0x7c/0xec
Jun 6 21:53:39 power kernel: [17883.048202] [c00000017a84fa30] [c00000000008bd00] .irq_exit+0x4c/0x9c
Jun 6 21:53:39 power kernel: [17883.050346] [c00000017a84fab0] [c00000000000ec18] .do_IRQ+0x1c4/0x240
Jun 6 21:53:39 power kernel: [17883.052489] [c00000017a84fb60] [c00000000000553c] hardware_interrupt_entry+0x18/0x1c
Jun 6 21:53:39 power kernel: [17883.054696] --- Exception: 501 at .cpu_idle+0x10c/0x1cc
Jun 6 21:53:39 power kernel: [17883.054697] LR = .cpu_idle+0x10c/0x1cc
Jun 6 21:53:39 power kernel: [17883.059158] [c00000017a84fe50] [c00000000001510c] .cpu_idle+0x64/0x1cc (unreliable)
Jun 6 21:53:39 power kernel: [17883.061470] [c00000017a84fee0] [c0000000004e5138] .start_secondary+0x33c/0x344
Jun 6 21:53:39 power kernel: [17883.063799] [c00000017a84ff90] [c0000000000093e8] .start_secondary_prolog+0x10/0x14
Jun 6 21:53:39 power kernel: [17883.066147] Mem-Info:
Jun 6 21:53:39 power kernel: [17883.068475] Node 0 DMA per-cpu:
Jun 6 21:53:39 power kernel: [17883.070832] CPU 0: hi: 186, btch: 31 usd: 110
Jun 6 21:53:39 power kernel: [17883.073241] CPU 1: hi: 186, btch: 31 usd: 164
Jun 6 21:53:39 power kernel: [17883.075656] CPU 2: hi: 186, btch: 31 usd: 157
Jun 6 21:53:39 power kernel: [17883.078065] CPU 3: hi: 186, btch: 31 usd: 43
Jun 6 21:53:39 power kernel: [17883.080456] active_anon:15030 inactive_anon:3094 isolated_anon:0
Jun 6 21:53:39 power kernel: [17883.080458] active_file:33851 inactive_file:895707 isolated_file:0
Jun 6 21:53:39 power kernel: [17883.080460] unevictable:0 dirty:4881 writeback:0 unstable:0
Jun 6 21:53:39 power kernel: [17883.080462] free:2893 slab_reclaimable:42793 slab_unreclaimable:4059
Jun 6 21:53:39 power kernel: [17883.080464] mapped:1413 shmem:8 pagetables:197 bounce:0
Jun 6 21:53:39 power kernel: [17883.092751] Node 0 DMA free:11572kB min:8104kB low:10128kB high:12156kB active_anon:60120kB inactive_anon:12376kB active_file:135404kB inactive_file:3582828kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:4108288kB mlocked:0kB dirty:19524kB writeback:0kB mapped:5652kB shmem:32kB slab_reclaimable:171172kB slab_unreclaimable:16236kB kernel_stack:1296kB pagetables:788kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jun 6 21:53:39 power kernel: [17883.100986] lowmem_reserve[]: 0 0 0
Jun 6 21:53:39 power kernel: [17883.103839] Node 0 DMA: 2589*4kB 4*8kB 16*16kB 9*32kB 2*64kB 2*128kB 1*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB 0*8192kB 0*16384kB = 11572kB
Jun 6 21:53:39 power kernel: [17883.106990] 929611 total pagecache pages
Jun 6 21:53:39 power kernel: [17883.110034] 0 pages in swap cache
Jun 6 21:53:39 power kernel: [17883.113077] Swap cache stats: add 146, delete 146, find 0/0
Jun 6 21:53:39 power kernel: [17883.116176] Free swap = 11777540kB
Jun 6 21:53:39 power kernel: [17883.119313] Total swap = 11778124kB
Jun 6 21:53:39 power kernel: [17883.138304] 1048576 pages RAM
Jun 6 21:53:39 power kernel: [17883.141526] 43458 pages reserved
Jun 6 21:53:39 power kernel: [17883.144701] 931357 pages shared
Jun 6 21:53:39 power kernel: [17883.147881] 72790 pages non-shared
Reply to: