On 10/4/12 1:53 AM, Linda Walsh wrote:
> These things happen once in a while...
>
> xfsdump = v 3.0.1, kern=3.2.29
>
> Not particularly worried -- most the time I don't notice them... just happened to be
> doing some leisure log reading...
>
> Though I should mention it in case it's indicating the world is ending or something...
> ;-/.
>
commit ad650f5b27bc9858360b42aaa0d9204d16115316
Author: Dave Chinner <dchinner@xxxxxxxxxx>
Date: Wed Mar 7 04:50:21 2012 +0000
xfs: fallback to vmalloc for large buffers in xfs_attrmulti_attr_get
It went into v3.4 upstream.
-eric
>
> Oct 3 05:07:35 Ishtar kernel: [868029.181590] Pid: 10418, comm: xfsdump Not tainted 3.2.29-Isht-Van #1
> Oct 3 05:07:35 Ishtar kernel: [868029.181594] Call Trace:
> Oct 3 05:07:35 Ishtar kernel: [868029.181604] [<ffffffff8111bc2d>] warn_alloc_failed+0xbd/0x150
> Oct 3 05:07:35 Ishtar kernel: [868029.181609] [<ffffffff8111e0c0>] ? page_alloc_cpu_notify+0x50/0x50
> Oct 3 05:07:35 Ishtar kernel: [868029.181614] [<ffffffff8111f7f8>] __alloc_pages_nodemask+0x668/0x870
> Oct 3 05:07:35 Ishtar kernel: [868029.181621] [<ffffffff81182ae3>] ? d_obtain_alias+0x73/0x260
> Oct 3 05:07:35 Ishtar kernel: [868029.181630] [<ffffffff81154dd1>] alloc_pages_current+0xb1/0x120
> Oct 3 05:07:35 Ishtar kernel: [868029.181635] [<ffffffff8111b539>] __get_free_pages+0x9/0x40
> Oct 3 05:07:35 Ishtar kernel: [868029.181641] [<ffffffff8115e1ea>] kmalloc_order_trace+0x3a/0x100
> Oct 3 05:07:35 Ishtar kernel: [868029.181647] [<ffffffff8115e81d>] __kmalloc+0x19d/0x1b0
> Oct 3 05:07:35 Ishtar kernel: [868029.181656] [<ffffffff812a9c4e>] xfs_attrlist_by_handle+0x8e/0x110
> Oct 3 05:07:35 Ishtar kernel: [868029.181662] [<ffffffff812aabd5>] xfs_file_ioctl+0x715/0x990
> Oct 3 05:07:35 Ishtar kernel: [868029.181671] [<ffffffff810abd55>] ? sched_clock_cpu+0xc5/0x120
> Oct 3 05:07:35 Ishtar kernel: [868029.181676] [<ffffffff810abd55>] ? sched_clock_cpu+0xc5/0x120
> Oct 3 05:07:35 Ishtar kernel: [868029.181683] [<ffffffff810b7a4e>] ? put_lock_stats.isra.21+0xe/0x40
> Oct 3 05:07:35 Ishtar kernel: [868029.181690] [<ffffffff810b7c9c>] ? lock_release_holdtime.part.22+0xdc/0x160
> Oct 3 05:07:35 Ishtar kernel: [868029.181697] [<ffffffff81189550>] ? clone_mnt+0x230/0x230
> Oct 3 05:07:35 Ishtar kernel: [868029.181705] [<ffffffff81077171>] ? sub_preempt_count+0x51/0x60
> Oct 3 05:07:35 Ishtar kernel: [868029.181711] [<ffffffff8117cc7e>] do_vfs_ioctl+0x8e/0x500
> Oct 3 05:07:35 Ishtar kernel: [868029.181716] [<ffffffff81189bda>] ? mntput+0x1a/0x30
> Oct 3 05:07:35 Ishtar kernel: [868029.181721] [<ffffffff8116ca43>] ? fput+0x173/0x220
> Oct 3 05:07:35 Ishtar kernel: [868029.181727] [<ffffffff8117d181>] sys_ioctl+0x91/0xa0
> Oct 3 05:07:35 Ishtar kernel: [868029.181734] [<ffffffff816aaebb>] system_call_fastpath+0x16/0x1b
> Oct 3 05:07:35 Ishtar kernel: [868029.181738] Mem-Info:
> Oct 3 05:07:35 Ishtar kernel: [868029.181741] Node 0 Normal per-cpu:
> Oct 3 05:07:35 Ishtar kernel: [868029.181746] CPU 0: hi: 186, btch: 31 usd: 168
> Oct 3 05:07:35 Ishtar kernel: [868029.181750] CPU 1: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181755] CPU 2: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181760] CPU 3: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181764] CPU 4: hi: 186, btch: 31 usd: 30
> Oct 3 05:07:35 Ishtar kernel: [868029.181769] CPU 5: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181772] CPU 6: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181776] CPU 7: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181779] CPU 8: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181783] CPU 9: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181787] CPU 10: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181791] CPU 11: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181795] Node 1 DMA per-cpu:
> Oct 3 05:07:35 Ishtar kernel: [868029.181799] CPU 0: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181802] CPU 1: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181806] CPU 2: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181810] CPU 3: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181814] CPU 4: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181818] CPU 5: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181820] CPU 6: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181825] CPU 7: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181829] CPU 8: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181832] CPU 9: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181836] CPU 10: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181840] CPU 11: hi: 0, btch: 1 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181844] Node 1 DMA32 per-cpu:
> Oct 3 05:07:35 Ishtar kernel: [868029.181848] CPU 0: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181852] CPU 1: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181857] CPU 2: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181861] CPU 3: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181864] CPU 4: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181868] CPU 5: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181873] CPU 6: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181877] CPU 7: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181881] CPU 8: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181885] CPU 9: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181888] CPU 10: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181892] CPU 11: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181896] Node 1 Normal per-cpu:
> Oct 3 05:07:35 Ishtar kernel: [868029.181900] CPU 0: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181904] CPU 1: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181907] CPU 2: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181911] CPU 3: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181915] CPU 4: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181919] CPU 5: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181921] CPU 6: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181925] CPU 7: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181930] CPU 8: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181933] CPU 9: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181936] CPU 10: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181940] CPU 11: hi: 186, btch: 31 usd: 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181946] active_anon:1798575 inactive_anon:180175 isolated_anon:0
> Oct 3 05:07:35 Ishtar kernel: [868029.181950] active_file:937817 inactive_file:8067246 isolated_file:0
> Oct 3 05:07:35 Ishtar kernel: [868029.181953] unevictable:3558 dirty:546666 writeback:0 unstable:0
> Oct 3 05:07:35 Ishtar kernel: [868029.181956] free:68778 slab_reclaimable:1019188 slab_unreclaimable:65696
> Oct 3 05:07:35 Ishtar kernel: [868029.181959] mapped:24472 shmem:13240 pagetables:12423 bounce:0
> Oct 3 05:07:35 Ishtar kernel: [868029.181964] Node 0 Normal free:72104kB min:45076kB low:56344kB high:67612kB active_anon:3020820kB inactive_anon:329484kB active_file:1607032kB inactive_file:17308528kB unevictable:10532kB isolated(anon):0kB isolated(file):0kB present:24772608kB mlocked:10532kB dirty:300756kB writeback:0kB mapped:49252kB shmem:29916kB slab_reclaimable:1828156kB slab_unreclaimable:133364kB kernel_stack:5104kB pagetables:23828kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:34 all_unreclaimable? no
> Oct 3 05:07:35 Ishtar kernel: [868029.181986] lowmem_reserve[]: 0 0 0 0
> Oct 3 05:07:35 Ishtar kernel: [868029.181993] Node 1 DMA free:15952kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15712kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
> Oct 3 05:07:35 Ishtar kernel: [868029.182012] lowmem_reserve[]: 0 3235 24151 24151
> Oct 3 05:07:35 Ishtar kernel: [868029.182020] Node 1 DMA32 free:103008kB min:6028kB low:7532kB high:9040kB active_anon:272264kB inactive_anon:66844kB active_file:246276kB inactive_file:1552524kB unevictable:552kB isolated(anon):0kB isolated(file):0kB present:3313380kB mlocked:552kB dirty:82244kB writeback:0kB mapped:1584kB shmem:120kB slab_reclaimable:1075216kB slab_unreclaimable:25644kB kernel_stack:2432kB pagetables:1212kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
> Oct 3 05:07:35 Ishtar kernel: [868029.182041] lowmem_reserve[]: 0 0 20916 20916
> Oct 3 05:07:35 Ishtar kernel: [868029.182048] Node 1 Normal free:84420kB min:38972kB low:48712kB high:58456kB active_anon:3901216kB inactive_anon:324372kB active_file:1897960kB inactive_file:13407932kB unevictable:3148kB isolated(anon):0kB isolated(file):0kB present:21417984kB mlocked:3148kB dirty:1803664kB writeback:0kB mapped:47052kB shmem:22924kB slab_reclaimable:1173380kB slab_unreclaimable:103760kB kernel_stack:2312kB pagetables:24652kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
> Oct 3 05:07:35 Ishtar kernel: [868029.182070] lowmem_reserve[]: 0 0 0 0
> Oct 3 05:07:35 Ishtar kernel: [868029.182077] Node 0 Normal: 15178*4kB 81*8kB 59*16kB 90*32kB 124*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 73120kB
> Oct 3 05:07:35 Ishtar kernel: [868029.182098] Node 1 DMA: 2*4kB 1*8kB 0*16kB 2*32kB 2*64kB 1*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 3*4096kB = 15952kB
> Oct 3 05:07:35 Ishtar kernel: [868029.182117] Node 1 DMA32: 23550*4kB 219*8kB 147*16kB 138*32kB 9*64kB 1*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 103424kB
> Oct 3 05:07:35 Ishtar kernel: [868029.182136] Node 1 Normal: 14238*4kB 845*8kB 1090*16kB 82*32kB 24*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 85312kB
> Oct 3 05:07:35 Ishtar kernel: [868029.182155] 9025559 total pagecache pages
> Oct 3 05:07:35 Ishtar kernel: [868029.182158] 6729 pages in swap cache
> Oct 3 05:07:35 Ishtar kernel: [868029.182162] Swap cache stats: add 3182931, delete 3176202, find 24716112/24876063
> Oct 3 05:07:35 Ishtar kernel: [868029.182165] Free swap = 8118348kB
> Oct 3 05:07:35 Ishtar kernel: [868029.182168] Total swap = 8393924kB
> Oct 3 05:07:35 Ishtar kernel: [868029.316121] 12582911 pages RAM
> Oct 3 05:07:35 Ishtar kernel: [868029.316125] 212769 pages reserved
> Oct 3 05:07:35 Ishtar kernel: [868029.316127] 2941502 pages shared
> Oct 3 05:07:35 Ishtar kernel: [868029.316129] 9548191 pages non-shared:0
>
> _______________________________________________
> xfs mailing list
> xfs@xxxxxxxxxxx
> http://oss.sgi.com/mailman/listinfo/xfs
>
_______________________________________________
xfs mailing list
xfs@xxxxxxxxxxx
http://oss.sgi.com/mailman/listinfo/xfs
