#12694 LOW 13.2.0: page allocation failure, mwifiex

[Zarro Boogs per Child]

#12694: page allocation failure, mwifiex
--------------------+-------------------------------------------------------
 Reporter:  Quozl   |                 Owner:           
     Type:  defect  |                Status:  new      
 Priority:  low     |             Milestone:  13.2.0   
Component:  kernel  |               Version:           
 Keywords:          |           Next_action:  reproduce
 Verified:  0       |   Deployment_affected:           
Blockedby:          |              Blocking:           
--------------------+-------------------------------------------------------
 Copying many files over wireless to a system using rsync over ssh caused a
 kernel message and the system could no longer be accessed over wireless.

 {{{
 [  490.687834] ksdioirqd/mmc0: page allocation failure: order:0,
 mode:0x120
 [  490.694515] [<c0015bc4>] (unwind_backtrace+0x0/0x128) from [<c0456418>]
 (dump_stack+0x20/0x24)
 [  490.703066] [<c0456418>] (dump_stack+0x20/0x24) from [<c00aee68>]
 (warn_alloc_failed+0x108/0x128)
 [  490.703066] [<c00aee68>] (warn_alloc_failed+0x108/0x128) from
 [<c00b1360>] (__alloc_pages_nodemask+0x53c/0x660)
 [  490.711868] [<c00b1360>] (__alloc_pages_nodemask+0x53c/0x660) from
 [<c036fafc>] (netdev_alloc_frag+0x44/0xe8)
 [  490.731716] [<c036fafc>] (netdev_alloc_frag+0x44/0xe8) from
 [<c0371194>] (__netdev_alloc_skb+0x3c/0xd4)
 [  490.731716] [<c0371194>] (__netdev_alloc_skb+0x3c/0xd4) from
 [<bf0eab5c>] (mwifiex_process_int_status+0x314/0xa14 [mwifiex_sdio])
 [  490.741050] [<bf0eab5c>] (mwifiex_process_int_status+0x314/0xa14
 [mwifiex_sdio]) from [<bf0ba180>] (mwifiex_main_process+0xf4/0x4c8
 [mwifiex])
 [  490.765336] [<bf0ba180>] (mwifiex_main_process+0xf4/0x4c8 [mwifiex])
 from [<bf0eb518>] (mwifiex_sdio_interrupt+0x15c/0x178 [mwifiex_sdio])
 [  490.765336] [<bf0eb518>] (mwifiex_sdio_interrupt+0x15c/0x178
 [mwifiex_sdio]) from [<c0305ba8>] (sdio_irq_thread+0x178/0x2f0)
 [  490.777674] [<c0305ba8>] (sdio_irq_thread+0x178/0x2f0) from
 [<c00467a4>] (kthread+0x9c/0xac)
 [  490.788805] [<c00467a4>] (kthread+0x9c/0xac) from [<c000fd80>]
 (kernel_thread_exit+0x0/0x8)
 [  490.797181] Mem-info:
 [  490.805456] Normal per-cpu:
 [  490.807704] CPU    0: hi:  186, btch:  31 usd:  30
 [  490.810470] HighMem per-cpu:
 [  490.818069] CPU    0: hi:   90, btch:  15 usd:  41
 [  490.822824] active_anon:21847 inactive_anon:1200 isolated_anon:0
 [  490.822824]  active_file:17233 inactive_file:138038 isolated_file:0
 [  490.822824]  unevictable:0 dirty:14511 writeback:0 unstable:0
 [  490.822824]  free:42081 slab_reclaimable:9464 slab_unreclaimable:1717
 [  490.822824]  mapped:10187 shmem:1481 pagetables:753 bounce:0
 [  490.822824] Normal free:167780kB min:3508kB low:4384kB high:5260kB
 active_anon:3676kB inactive_anon:4kB active_file:33148kB
 inactive_file:415216kB unevictable:0kB isolated(anon):0kB
 isolated(file):0kB present:772160kB mlocked:0kB dirty:58044kB
 writeback:0kB mapped:0kB shmem:4kB slab_reclaimable:37856kB
 slab_unreclaimable:6868kB kernel_stack:1264kB pagetables:3012kB
 unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0
 all_unreclaimable? no
 [  490.852664] lowmem_reserve[]: 0 2032 2032
 [  490.891616] HighMem free:544kB min:252kB low:544kB high:840kB
 active_anon:83712kB inactive_anon:4796kB active_file:35784kB
 inactive_file:136936kB unevictable:0kB isolated(anon):0kB
 isolated(file):0kB present:260096kB mlocked:0kB dirty:0kB writeback:0kB
 mapped:40748kB shmem:5920kB slab_reclaimable:0kB slab_unreclaimable:0kB
 kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB
 pages_scanned:0 all_unreclaimable? no
 [  490.933607] lowmem_reserve[]: 0 0 0
 [  490.933607] Normal: 1391*4kB 1389*8kB 1390*16kB 1391*32kB 1318*64kB
 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB 0*8192kB 0*16384kB
 0*32768kB = 167780kB
 [  490.951113] HighMem: 2*4kB 1*8kB 1*16kB 0*32kB 0*64kB 0*128kB 0*256kB
 1*512kB 0*1024kB 0*2048kB 0*4096kB 0*8192kB 0*16384kB 0*32768kB = 544kB
 [  490.951113] 156761 total pagecache pages
 [  490.967595] 0 pages in swap cache
 [  490.970879] Swap cache stats: add 0, delete 0, find 0/0
 [  490.970879] Free swap  = 0kB
 [  490.976055] Total swap = 0kB
 [  490.978907] 260096 pages of RAM
 [  491.003494] 42528 free pages
 [  491.006608] 4172 reserved pages
 [  491.012568] 11181 slab pages
 [  491.012568] 179484 pages shared
 [  491.015420] 0 pages swap cached
 [  491.021797] mwifiex_sdio mmc0:0001:1: mwifiex_process_int_status:
 failed to alloc skb
 [  501.054266] mwifiex_sdio mmc0:0001:1: mwifiex_cmd_timeout_func: Timeout
 cmd id (1370331855.479994) = 0xa4, act = 0x0
 [  501.064775] mwifiex_sdio mmc0:0001:1: num_data_h2c_failure = 0
 [  501.064775] mwifiex_sdio mmc0:0001:1: num_cmd_h2c_failure = 0
 [  501.076260] mwifiex_sdio mmc0:0001:1: num_cmd_timeout = 1
 [  501.081621] mwifiex_sdio mmc0:0001:1: num_tx_timeout = 0
 [  501.086903] mwifiex_sdio mmc0:0001:1: last_cmd_index = 2
 [  501.092177] mwifiex_sdio mmc0:0001:1: last_cmd_resp_index = 1
 [  501.097900] mwifiex_sdio mmc0:0001:1: last_event_index = 3
 [  501.103342] mwifiex_sdio mmc0:0001:1: data_sent=0 cmd_sent=1
 [  501.108971] mwifiex_sdio mmc0:0001:1: ps_mode=0 ps_state=0
 }}}

 This was on a custom build based on 13.2.0, with kernel hash aeff3e2,
 (despite f0a3916 being the latest in git), without Sugar.  olpc-os-builder
 patch: http://dev.laptop.org/~quozl/z/1Ujm4Z.txt

-- 
Ticket URL: <http://dev.laptop.org/ticket/12694>
One Laptop Per Child <http://laptop.org/>
OLPC bug tracking system