From mboxrd@z Thu Jan  1 00:00:00 1970
Return-path: <linux-wireless-owner@vger.kernel.org>
Received: from atrey.karlin.mff.cuni.cz ([195.113.26.193]:60016 "EHLO
	atrey.karlin.mff.cuni.cz" rhost-flags-OK-OK-OK-OK) by vger.kernel.org
	with ESMTP id S1754038Ab2IIVcb (ORCPT
	<rfc822;linux-wireless@vger.kernel.org>);
	Sun, 9 Sep 2012 17:32:31 -0400
Date: Sun, 9 Sep 2012 23:32:28 +0200
From: Pavel Machek <pavel@ucw.cz>
To: sgruszka@redhat.com, linux-wireless@vger.kernel.org,
	johannes.berg@intel.com, wey-yi.w.guy@intel.com,
	ilw@linux.intel.com, kernel list <linux-kernel@vger.kernel.org>
Cc: Andrew Morton <akpm@osdl.org>, linux-mm@kvack.org
Subject: iwl3945: order 5 allocation during ifconfig up; vm problem?
Message-ID: <20120909213228.GA5538@elf.ucw.cz> (sfid-20120909_233246_619096_FF5D9D4E)
MIME-Version: 1.0
Content-Type: text/plain; charset=us-ascii
Sender: linux-wireless-owner@vger.kernel.org
List-ID: <linux-wireless.vger.kernel.org>

Hi!

On 3.6.0-rc2+, I tried to turn on the wireless, but got

root@amd:~# ifconfig wlan0 10.0.0.6 up
SIOCSIFFLAGS: Cannot allocate memory
SIOCSIFFLAGS: Cannot allocate memory
root@amd:~# 

It looks like it uses "a bit too big" allocations to allocate
firmware...? Order five allocation....

Hmm... then I did "echo 3  > /proc/sys/vm/drop_caches" and now the
network works. Is it VM problem that it failed to allocate memory when
it was freeable?

							Pavel

iwl3945 0000:03:00.0: failed to allocate pci memory
iwl3945 0000:03:00.0: Could not read microcode: -12
firmware 0000:03:00.0: firmware_loading_store: vmap() failed
iwl3945 0000:03:00.0: iwlwifi-3945-2.ucode firmware file req failed:
-2
iwl3945 0000:03:00.0: Loaded firmware iwlwifi-3945-1.ucode, which is
deprecated.  Please use API v2 instead.
iwl3945 0000:03:00.0: loaded firmware version 15.32.2.9
ifconfig: page allocation failure: order:5, mode:0x80d0
Pid: 21116, comm: ifconfig Tainted: G        W    3.6.0-rc2+ #228
Call Trace:
 [<c029ebf6>] warn_alloc_failed+0xb6/0x100
 [<c02a0321>] __alloc_pages_nodemask+0x4c1/0x6e0
 [<c020699c>] dma_generic_alloc_coherent+0x8c/0xc0
 [<c05c4d59>] il3945_mac_start+0x1269/0x1280
 [<c0206910>] ? dma_generic_free_coherent+0x30/0x30
 [<c0800f64>] ? packet_notifier+0xc4/0x1a0
 [<c088094c>] ieee80211_do_open+0x28c/0x840
 [<c087f399>] ? ieee80211_check_concurrent_iface+0x19/0x190
 [<c024c7ea>] ? raw_notifier_call_chain+0x1a/0x20
 [<c0880f3b>] ieee80211_open+0x3b/0x80
 [<c0769966>] __dev_open+0x96/0xf0
 [<c08c73a5>] ? _raw_spin_unlock_bh+0x25/0x30
 [<c076633d>] __dev_change_flags+0x7d/0x150
 [<c076988e>] dev_change_flags+0x1e/0x60
 [<c07d819d>] devinet_ioctl+0x69d/0x770
 [<c076b026>] ? dev_ioctl+0x336/0x740
 [<c07d959a>] inet_ioctl+0x9a/0xc0
 [<c0756a33>] sock_ioctl+0x63/0x240
 [<c07569d0>] ? sock_fasync+0x80/0x80
 [<c02d91a3>] do_vfs_ioctl+0x83/0x570
 [<c0223a50>] ? mm_fault_error+0x170/0x170
 [<c024ba86>] ? up_read+0x16/0x30
 [<c0223bcc>] ? do_page_fault+0x17c/0x3b0
 [<c02d96c9>] sys_ioctl+0x39/0x70
 [<c08c7c10>] sysenter_do_call+0x12/0x31
Mem-Info:
DMA per-cpu:
CPU    0: hi:    0, btch:   1 usd:   0
CPU    1: hi:    0, btch:   1 usd:   0
Normal per-cpu:
CPU    0: hi:  186, btch:  31 usd:  30
CPU    1: hi:  186, btch:  31 usd:   0
HighMem per-cpu:
CPU    0: hi:  186, btch:  31 usd:   0
CPU    1: hi:  186, btch:  31 usd:   0
active_anon:250783 inactive_anon:118977 isolated_anon:0
 active_file:14686 inactive_file:13826 isolated_file:0
 unevictable:0 dirty:3050 writeback:0 unstable:0
 free:30113 slab_reclaimable:43820 slab_unreclaimable:34426
 mapped:11898 shmem:19084 pagetables:3043 bounce:0
DMA free:1580kB min:64kB low:80kB high:96kB active_anon:0kB
inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB
isolated(anon):0kB isolated(file):0kB present:15788kB mlocked:0kB
dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB
slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB
bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
lowmem_reserve[]: 0 864 2005 2005
Normal free:115348kB min:3728kB low:4660kB high:5592kB
active_anon:193616kB inactive_anon:192540kB active_file:19528kB
inactive_file:12916kB unevictable:0kB isolated(anon):0kB
isolated(file):0kB present:885072kB mlocked:0kB dirty:5388kB
writeback:0kB mapped:9212kB shmem:29100kB slab_reclaimable:175280kB
slab_unreclaimable:137704kB kernel_stack:6032kB pagetables:12172kB
unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0
all_unreclaimable? no
lowmem_reserve[]: 0 0 9125 9125
HighMem free:3524kB min:512kB low:1740kB high:2972kB
active_anon:809516kB inactive_anon:283368kB active_file:39216kB
inactive_file:42388kB unevictable:0kB isolated(anon):0kB
isolated(file):0kB present:1168080kB mlocked:0kB dirty:6812kB
writeback:0kB mapped:38380kB shmem:47236kB slab_reclaimable:0kB
slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB
bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 1*4kB 1*8kB 0*16kB 1*32kB 2*64kB 1*128kB 1*256kB 0*512kB 1*1024kB
0*2048kB 0*4096kB = 1580kB
Normal: 4729*4kB 8354*8kB 1683*16kB 74*32kB 4*64kB 0*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 115300kB
HighMem: 537*4kB 118*8kB 27*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB
0*1024kB 0*2048kB 0*4096kB = 3524kB
62305 total pagecache pages
14672 pages in swap cache
Swap cache stats: add 96156, delete 81484, find 3042279/3044117
Free swap  = 480024kB
Total swap = 779148kB
521920 pages RAM
294610 pages HighMem
9083 pages reserved
244243 pages shared
450983 pages non-shared
iwl3945 0000:03:00.0: failed to allocate pci memory
iwl3945 0000:03:00.0: Could not read microcode: -12

-- 
(english) http://www.livejournal.com/~pavelmachek
(cesky, pictures) http://atrey.karlin.mff.cuni.cz/~pavel/picture/horses/blog.html

From mboxrd@z Thu Jan  1 00:00:00 1970
Return-Path: <owner-linux-mm@kvack.org>
Received: from psmtp.com (na3sys010amx120.postini.com [74.125.245.120])
	by kanga.kvack.org (Postfix) with SMTP id 000EE6B005D
	for <linux-mm@kvack.org>; Sun,  9 Sep 2012 17:32:30 -0400 (EDT)
Date: Sun, 9 Sep 2012 23:32:28 +0200
From: Pavel Machek <pavel@ucw.cz>
Subject: iwl3945: order 5 allocation during ifconfig up; vm problem?
Message-ID: <20120909213228.GA5538@elf.ucw.cz>
MIME-Version: 1.0
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
Sender: owner-linux-mm@kvack.org
List-ID: <linux-mm.kvack.org>
To: sgruszka@redhat.com, linux-wireless@vger.kernel.org, johannes.berg@intel.com, wey-yi.w.guy@intel.com, ilw@linux.intel.com, kernel list <linux-kernel@vger.kernel.org>
Cc: Andrew Morton <akpm@osdl.org>, linux-mm@kvack.org

Hi!

On 3.6.0-rc2+, I tried to turn on the wireless, but got

root@amd:~# ifconfig wlan0 10.0.0.6 up
SIOCSIFFLAGS: Cannot allocate memory
SIOCSIFFLAGS: Cannot allocate memory
root@amd:~# 

It looks like it uses "a bit too big" allocations to allocate
firmware...? Order five allocation....

Hmm... then I did "echo 3  > /proc/sys/vm/drop_caches" and now the
network works. Is it VM problem that it failed to allocate memory when
it was freeable?

							Pavel

iwl3945 0000:03:00.0: failed to allocate pci memory
iwl3945 0000:03:00.0: Could not read microcode: -12
firmware 0000:03:00.0: firmware_loading_store: vmap() failed
iwl3945 0000:03:00.0: iwlwifi-3945-2.ucode firmware file req failed:
-2
iwl3945 0000:03:00.0: Loaded firmware iwlwifi-3945-1.ucode, which is
deprecated.  Please use API v2 instead.
iwl3945 0000:03:00.0: loaded firmware version 15.32.2.9
ifconfig: page allocation failure: order:5, mode:0x80d0
Pid: 21116, comm: ifconfig Tainted: G        W    3.6.0-rc2+ #228
Call Trace:
 [<c029ebf6>] warn_alloc_failed+0xb6/0x100
 [<c02a0321>] __alloc_pages_nodemask+0x4c1/0x6e0
 [<c020699c>] dma_generic_alloc_coherent+0x8c/0xc0
 [<c05c4d59>] il3945_mac_start+0x1269/0x1280
 [<c0206910>] ? dma_generic_free_coherent+0x30/0x30
 [<c0800f64>] ? packet_notifier+0xc4/0x1a0
 [<c088094c>] ieee80211_do_open+0x28c/0x840
 [<c087f399>] ? ieee80211_check_concurrent_iface+0x19/0x190
 [<c024c7ea>] ? raw_notifier_call_chain+0x1a/0x20
 [<c0880f3b>] ieee80211_open+0x3b/0x80
 [<c0769966>] __dev_open+0x96/0xf0
 [<c08c73a5>] ? _raw_spin_unlock_bh+0x25/0x30
 [<c076633d>] __dev_change_flags+0x7d/0x150
 [<c076988e>] dev_change_flags+0x1e/0x60
 [<c07d819d>] devinet_ioctl+0x69d/0x770
 [<c076b026>] ? dev_ioctl+0x336/0x740
 [<c07d959a>] inet_ioctl+0x9a/0xc0
 [<c0756a33>] sock_ioctl+0x63/0x240
 [<c07569d0>] ? sock_fasync+0x80/0x80
 [<c02d91a3>] do_vfs_ioctl+0x83/0x570
 [<c0223a50>] ? mm_fault_error+0x170/0x170
 [<c024ba86>] ? up_read+0x16/0x30
 [<c0223bcc>] ? do_page_fault+0x17c/0x3b0
 [<c02d96c9>] sys_ioctl+0x39/0x70
 [<c08c7c10>] sysenter_do_call+0x12/0x31
Mem-Info:
DMA per-cpu:
CPU    0: hi:    0, btch:   1 usd:   0
CPU    1: hi:    0, btch:   1 usd:   0
Normal per-cpu:
CPU    0: hi:  186, btch:  31 usd:  30
CPU    1: hi:  186, btch:  31 usd:   0
HighMem per-cpu:
CPU    0: hi:  186, btch:  31 usd:   0
CPU    1: hi:  186, btch:  31 usd:   0
active_anon:250783 inactive_anon:118977 isolated_anon:0
 active_file:14686 inactive_file:13826 isolated_file:0
 unevictable:0 dirty:3050 writeback:0 unstable:0
 free:30113 slab_reclaimable:43820 slab_unreclaimable:34426
 mapped:11898 shmem:19084 pagetables:3043 bounce:0
DMA free:1580kB min:64kB low:80kB high:96kB active_anon:0kB
inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB
isolated(anon):0kB isolated(file):0kB present:15788kB mlocked:0kB
dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB
slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB
bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
lowmem_reserve[]: 0 864 2005 2005
Normal free:115348kB min:3728kB low:4660kB high:5592kB
active_anon:193616kB inactive_anon:192540kB active_file:19528kB
inactive_file:12916kB unevictable:0kB isolated(anon):0kB
isolated(file):0kB present:885072kB mlocked:0kB dirty:5388kB
writeback:0kB mapped:9212kB shmem:29100kB slab_reclaimable:175280kB
slab_unreclaimable:137704kB kernel_stack:6032kB pagetables:12172kB
unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0
all_unreclaimable? no
lowmem_reserve[]: 0 0 9125 9125
HighMem free:3524kB min:512kB low:1740kB high:2972kB
active_anon:809516kB inactive_anon:283368kB active_file:39216kB
inactive_file:42388kB unevictable:0kB isolated(anon):0kB
isolated(file):0kB present:1168080kB mlocked:0kB dirty:6812kB
writeback:0kB mapped:38380kB shmem:47236kB slab_reclaimable:0kB
slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB
bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 1*4kB 1*8kB 0*16kB 1*32kB 2*64kB 1*128kB 1*256kB 0*512kB 1*1024kB
0*2048kB 0*4096kB = 1580kB
Normal: 4729*4kB 8354*8kB 1683*16kB 74*32kB 4*64kB 0*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 115300kB
HighMem: 537*4kB 118*8kB 27*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB
0*1024kB 0*2048kB 0*4096kB = 3524kB
62305 total pagecache pages
14672 pages in swap cache
Swap cache stats: add 96156, delete 81484, find 3042279/3044117
Free swap  = 480024kB
Total swap = 779148kB
521920 pages RAM
294610 pages HighMem
9083 pages reserved
244243 pages shared
450983 pages non-shared
iwl3945 0000:03:00.0: failed to allocate pci memory
iwl3945 0000:03:00.0: Could not read microcode: -12

-- 
(english) http://www.livejournal.com/~pavelmachek
(cesky, pictures) http://atrey.karlin.mff.cuni.cz/~pavel/picture/horses/blog.html

--
To unsubscribe, send a message with 'unsubscribe linux-mm' in
the body to majordomo@kvack.org.  For more info on Linux MM,
see: http://www.linux-mm.org/ .
Don't email: <a href=mailto:"dont@kvack.org"> email@kvack.org </a>