lkml.org 
[lkml]   [2012]   [Dec]   [22]   [last100]   RSS Feed
Views: [wrap][no wrap]   [headers]  [forward] 
 
Messages in this thread
/
Date
From
SubjectRe: Regression in 3.8-rc1: "BUG: sleeping function called from invalid context"
Top-posting so that the rest can remain untouched.

Right, so AFAICT, something is holding rtnl_mutex (probably some
rtnetlink traffic) and device_rename() is doing kstrdup with
GFP_KERNEL which, among others, has __GFP_WAIT and *that* triggers the
might_sleep_if() check in slab_pre_alloc_hook():

static inline int slab_pre_alloc_hook(struct kmem_cache *s, gfp_t flags)
{
flags &= gfp_allowed_mask;
lockdep_trace_alloc(flags);
might_sleep_if(flags & __GFP_WAIT); <--- HERE

Adding Christoph and Pekka although the slub.c might_sleep stuff is from
2010. Still, they might have a better idea.

Oh well, let's add netdev while we're at it. :-)

HTH.

On Sat, Dec 22, 2012 at 11:11:53AM -0600, Larry Finger wrote:
> With kernel 3.8-rc1, I get 2 "BUG: sleeping function called from
> invalid context" reports. These have been present got some time in
> the 3.7-git versions and I have tried twice to bisect the problem.
> Both times, I ended up at a merge commit. The most recent found
> commit a11da7d as the bad one, and commit d7460f4 as the last good
> one. I have not had time to make a third try.
>
> My system is x86_64 running on an HP laptop with a dual-core AMD
> CPU. My configuration file is attached.
>
> The logged details are as follows:
>
> [ 31.715016] BUG: sleeping function called from invalid context at mm/slub.c:925
> [ 31.715022] in_atomic(): 1, irqs_disabled(): 0, pid: 2129, name: udevd
> [ 31.715025] 2 locks held by udevd/2129:
> [ 31.715028] #0: (rtnl_mutex){+.+.+.}, at: [<ffffffff81386382>]
> rtnl_lock+0x12/0x20
> [ 31.715041] #1: (devnet_rename_seq){+.+.+.}, at:
> [<ffffffff81376033>] dev_change_name+0x43/0x260
> [ 31.715053] Pid: 2129, comm: udevd Not tainted 3.8.0-rc1 #56
> [ 31.715056] Call Trace:
> [ 31.715063] [<ffffffff81076ca2>] __might_sleep+0x152/0x250
> [ 31.715068] [<ffffffff8114a353>] __kmalloc_track_caller+0x103/0x280
> [ 31.715073] [<ffffffff812d595d>] ? device_rename+0x4d/0xf0
> [ 31.715078] [<ffffffff8111d675>] kstrdup+0x35/0x70
> [ 31.715082] [<ffffffff812d595d>] device_rename+0x4d/0xf0
> [ 31.715086] [<ffffffff813760ca>] dev_change_name+0xda/0x260
> [ 31.715091] [<ffffffff81377f51>] dev_ifsioc+0x241/0x3a0
> [ 31.715095] [<ffffffff81378410>] dev_ioctl+0x360/0x830
> [ 31.715101] [<ffffffff810a54cd>] ? trace_hardirqs_on+0xd/0x10
> [ 31.715106] [<ffffffff8135b711>] sock_do_ioctl.constprop.41+0x41/0x50
> [ 31.715109] [<ffffffff8135b9c6>] sock_ioctl+0x66/0x2b0
> [ 31.715115] [<ffffffff811637b7>] do_vfs_ioctl+0x97/0x580
> [ 31.715119] [<ffffffff8116f27a>] ? fget_light+0x3da/0x4d0
> [ 31.715124] [<ffffffff81422a55>] ? sysret_check+0x22/0x5d
> [ 31.715128] [<ffffffff81163ceb>] sys_ioctl+0x4b/0x90
> [ 31.715133] [<ffffffff8121a69e>] ? trace_hardirqs_on_thunk+0x3a/0x3f
> [ 31.715136] [<ffffffff81422a29>] system_call_fastpath+0x16/0x1b
> [ 31.715764] BUG: scheduling while atomic: udevd/2129/0x00000002
> [ 31.715768] 2 locks held by udevd/2129:
> [ 31.715769] #0: (rtnl_mutex){+.+.+.}, at: [<ffffffff81386382>]
> rtnl_lock+0x12/0x20
> [ 31.715779] #1: (devnet_rename_seq){+.+.+.}, at:
> [<ffffffff81376033>] dev_change_name+0x43/0x260
> [ 31.715787] Modules linked in: b43 arc4 rtl8723ae rtlwifi
> mac80211 snd_hda_codec_conexant snd_hda_intel snd_hda_codec cfg80211
> powernow_k8 kvm_amd snd_pcm_oss kvm snd_pcm snd_seq bcma rng_core
> ssb snd_timer mmc_core snd_seq_device pcmcia rfkill snd sr_mod cdrom
> soundcore ehci_pci battery pcmcia_core sg k8temp ac i2c_nforce2
> hwmon forcedeth video snd_page_alloc serio_raw i2c_core joydev wmi
> button ipv6 autofs4 ext4 mbcache jbd2 crc16 ohci_hcd ehci_hcd
> usbcore usb_common thermal processor scsi_dh_rdac scsi_dh_alua
> scsi_dh_emc scsi_dh_hp_sw scsi_dh ata_generic pata_amd
> [ 31.715867] Pid: 2129, comm: udevd Not tainted 3.8.0-rc1 #56
> [ 31.715868] Call Trace:
> [ 31.715874] [<ffffffff8141987c>] __schedule_bug+0x62/0x70
> [ 31.715878] [<ffffffff81420160>] __schedule+0x730/0xa30
> [ 31.715883] [<ffffffff810a3982>] ? __lock_acquire+0x12d2/0x1c50
> [ 31.715888] [<ffffffff81420744>] schedule+0x24/0x70
> [ 31.715893] [<ffffffff8141dc5c>] schedule_timeout+0x18c/0x2f0
> [ 31.715897] [<ffffffff810a52ac>] ? mark_held_locks+0x8c/0x110
> [ 31.715902] [<ffffffff81421b9b>] ? _raw_spin_unlock_irq+0x2b/0x50
> [ 31.715906] [<ffffffff810a5435>] ? trace_hardirqs_on_caller+0x105/0x190
> [ 31.715911] [<ffffffff810a54cd>] ? trace_hardirqs_on+0xd/0x10
> [ 31.715915] [<ffffffff814205d5>] wait_for_common+0xe5/0x180
> [ 31.715919] [<ffffffff8107d010>] ? try_to_wake_up+0x2d0/0x2d0
> [ 31.715924] [<ffffffff81420718>] wait_for_completion+0x18/0x20
> [ 31.715929] [<ffffffff8105f48c>] call_usermodehelper_exec+0x19c/0x1d0
> [ 31.715935] [<ffffffff8105f592>] call_usermodehelper_fns+0xd2/0x100
> [ 31.715941] [<ffffffff8121211d>] kobject_uevent_env+0x47d/0x4b0
> [ 31.715946] [<ffffffff812110df>] kobject_rename+0x12f/0x140
> [ 31.715951] [<ffffffff812d59db>] device_rename+0xcb/0xf0
> [ 31.715955] [<ffffffff813760ca>] dev_change_name+0xda/0x260
> [ 31.715960] [<ffffffff81377f51>] dev_ifsioc+0x241/0x3a0
> [ 31.715965] [<ffffffff81378410>] dev_ioctl+0x360/0x830
> [ 31.715969] [<ffffffff810a54cd>] ? trace_hardirqs_on+0xd/0x10
> [ 31.715974] [<ffffffff8135b711>] sock_do_ioctl.constprop.41+0x41/0x50
> [ 31.715978] [<ffffffff8135b9c6>] sock_ioctl+0x66/0x2b0
> [ 31.715982] [<ffffffff811637b7>] do_vfs_ioctl+0x97/0x580
> [ 31.715987] [<ffffffff8116f27a>] ? fget_light+0x3da/0x4d0
> [ 31.715991] [<ffffffff81422a55>] ? sysret_check+0x22/0x5d
> [ 31.716092] [<ffffffff81163ceb>] sys_ioctl+0x4b/0x90
> [ 31.716097] [<ffffffff8121a69e>] ? trace_hardirqs_on_thunk+0x3a/0x3f
> [ 31.716102] [<ffffffff81422a29>] system_call_fastpath+0x16/0x1b



--
Regards/Gruss,
Boris.

Sent from a fat crate under my desk. Formatting is fine.
--


\
 
 \ /
  Last update: 2012-12-22 19:21    [W:0.039 / U:2.168 seconds]
©2003-2020 Jasper Spaans|hosted at Digital Ocean and TransIP|Read the blog|Advertise on this site