Kernel 2.6.35.2 reports "scheduling while atomic"

[ReneS]

Was trying the latest 2.6.35.2 Maverick kernel from kernel mainline archive. Seeing this during boot. Also encountered boot hangs and freezing when starting application. Wanted to try that kernel before trying it on my T500 (2.6.35 has suspend problems).

Description: Ubuntu 10.04.1 LTS
Release: 10.04

Linux rswind 2.6.35-02063502-generic #02063502 SMP Mon Aug 16 12:41:19 UTC 2010 i686 GNU/Linux

Aug 16 21:25:06 rswind kernel: [ 1.809098] BUG: scheduling while atomic: udevd/225/0x10000001
Aug 16 21:25:06 rswind kernel: [ 1.809156] Modules linked in: mii
Aug 16 21:25:06 rswind kernel: [ 1.809172] Pid: 225, comm: udevd Not tainted 2.6.35-02063502-generic #02063502
Aug 16 21:25:06 rswind kernel: [ 1.809179] Call Trace:
Aug 16 21:25:06 rswind kernel: [ 1.809199] [<c013fd15>] __schedule_bug+0x65/0x70
Aug 16 21:25:06 rswind kernel: [ 1.809213] [<c05c6a9e>] schedule+0x42e/0x5b0
Aug 16 21:25:06 rswind kernel: [ 1.809226] [<c014a55b>] __cond_resched+0x1b/0x30
Aug 16 21:25:06 rswind kernel: [ 1.809237] [<c05c6d45>] _cond_resched+0x25/0x30
Aug 16 21:25:06 rswind kernel: [ 1.809250] [<c01fc4ce>] anon_vma_prepare+0x1e/0x140
Aug 16 21:25:06 rswind kernel: [ 1.809264] [<c01e0d7d>] ? __alloc_pages_nodemask+0xdd/0x1b0
Aug 16 21:25:06 rswind kernel: [ 1.809277] [<c01f863d>] expand_downwards+0x1d/0xb0
Aug 16 21:25:06 rswind kernel: [ 1.809291] [<c01f86dd>] expand_stack+0xd/0x10
Aug 16 21:25:06 rswind kernel: [ 1.809302] [<c01f34fd>] do_anonymous_page+0x2dd/0x2f0
Aug 16 21:25:06 rswind kernel: [ 1.809315] [<c01f6462>] handle_mm_fault+0x262/0x2c0
Aug 16 21:25:06 rswind kernel: [ 1.809328] [<c01f8705>] ? find_extend_vma+0x25/0x70
Aug 16 21:25:06 rswind kernel: [ 1.809340] [<c01f6614>] __get_user_pages+0x154/0x420
Aug 16 21:25:06 rswind kernel: [ 1.809353] [<c01e06b8>] ? get_page_from_freelist+0x118/0x2a0
Aug 16 21:25:06 rswind kernel: [ 1.809366] [<c01f6984>] get_user_pages+0x54/0x70
Aug 16 21:25:06 rswind kernel: [ 1.809380] [<c021ef25>] get_arg_page+0x55/0xb0
Aug 16 21:25:06 rswind kernel: [ 1.809394] [<c0355c30>] ? strnlen_user+0x30/0x60
Aug 16 21:25:06 rswind kernel: [ 1.809405] [<c021f067>] copy_strings+0xe7/0x190
Aug 16 21:25:06 rswind kernel: [ 1.809417] [<c021f139>] copy_strings_kernel+0x29/0x40
Aug 16 21:25:06 rswind kernel: [ 1.809428] [<c0220f4e>] do_execve+0x1ee/0x2b0
Aug 16 21:25:06 rswind kernel: [ 1.809439] [<c0109bc7>] sys_execve+0x37/0x70
Aug 16 21:25:06 rswind kernel: [ 1.809450] [<c0102dae>] ptregs_execve+0x12/0x18
Aug 16 21:25:06 rswind kernel: [ 1.809462] [<c05c8da4>] ? syscall_call+0x7/0xb
Aug 16 21:25:06 rswind kernel: [ 1.844935] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
Aug 16 21:25:06 rswind kernel: [ 1.844992] r8169 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
Aug 16 21:25:06 rswind kernel: [ 1.877341] r8169 0000:01:00.0: setting latency timer to 64
Aug 16 21:25:06 rswind kernel: [ 1.877413] alloc irq_desc for 42 on node -1
Aug 16 21:25:06 rswind kernel: [ 1.877422] alloc kstat_irqs on node -1
Aug 16 21:25:06 rswind kernel: [ 1.877450] r8169 0000:01:00.0: irq 42 for MSI/MSI-X
Aug 16 21:25:06 rswind kernel: [ 1.879235] r8169 0000:01:00.0: eth0: RTL8102e at 0xf803a000, 00:21:85:48:66:cd, XID 14a00000 IRQ 42
Aug 16 21:25:06 rswind kernel: [ 1.914119] ahci 0000:00:1f.2: version 3.0
Aug 16 21:25:06 rswind kernel: [ 1.914156] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
Aug 16 21:25:06 rswind kernel: [ 1.914239] alloc irq_desc for 43 on node -1
Aug 16 21:25:06 rswind kernel: [ 1.914248] alloc kstat_irqs on node -1
Aug 16 21:25:06 rswind kernel: [ 1.914274] ahci 0000:00:1f.2: irq 43 for MSI/MSI-X
Aug 16 21:25:06 rswind kernel: [ 1.914517] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 4 ports 1.5 Gbps 0x5 impl SATA mode
Aug 16 21:25:06 rswind kernel: [ 1.914532] ahci 0000:00:1f.2: flags: 64bit ncq pm led clo pio slum part
Aug 16 21:25:06 rswind kernel: [ 1.914545] ahci 0000:00:1f.2: setting latency timer to 64
Aug 16 21:25:06 rswind kernel: [ 1.915702] scsi0 : ahci
Aug 16 21:25:06 rswind kernel: [ 1.916216] scsi1 : ahci
Aug 16 21:25:06 rswind kernel: [ 1.916688] scsi2 : ahci
Aug 16 21:25:06 rswind kernel: [ 1.917168] scsi3 : ahci
Aug 16 21:25:06 rswind kernel: [ 1.917358] ata1: SATA max UDMA/133 abar m1024@0xdff40000 port 0xdff40100 irq 43
Aug 16 21:25:06 rswind kernel: [ 1.917368] ata2: DUMMY
Aug 16 21:25:06 rswind kernel: [ 1.917377] ata3: SATA max UDMA/133 abar m1024@0xdff40000 port 0xdff40200 irq 43
Aug 16 21:25:06 rswind kernel: [ 1.917386] ata4: DUMMY
Aug 16 21:25:06 rswind kernel: [ 1.933199] Initializing USB Mass Storage driver...
Aug 16 21:25:06 rswind kernel: [ 1.933553] scsi4 : usb-storage 1-6:1.0
Aug 16 21:25:06 rswind kernel: [ 1.933825] usbcore: registered new interface driver usb-storage
Aug 16 21:25:06 rswind kernel: [ 1.933833] USB Mass Storage support registered.
Aug 16 21:25:06 rswind kernel: [ 2.236161] ata3: SATA link down (SStatus 0 SControl 300)
Aug 16 21:25:06 rswind kernel: [ 2.236213] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Aug 16 21:25:06 rswind kernel: [ 2.285880] ata1.00: ATA-7: WDC WD800BEVS-22RST0, 04.01G04, max UDMA/133
Aug 16 21:25:06 rswind kernel: [ 2.285897] ata1.00: 156301488 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
Aug 16 21:25:06 rswind kernel: [ 2.286984] ata1.00: configured for UDMA/133
Aug 16 21:25:06 rswind kernel: [ 2.300523] scsi 0:0:0:0: Direct-Access ATA WDC WD800BEVS-22 04.0 PQ: 0 ANSI: 5
Aug 16 21:25:06 rswind kernel: [ 2.301104] sd 0:0:0:0: Attached scsi generic sg0 type 0
Aug 16 21:25:06 rswind kernel: [ 2.301419] sd 0:0:0:0: [sda] 156301488 512-byte logical blocks: (80.0 GB/74.5 GiB)
Aug 16 21:25:06 rswind kernel: [ 2.301615] sd 0:0:0:0: [sda] Write Protect is off
Aug 16 21:25:06 rswind kernel: [ 2.301623] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
Aug 16 21:25:06 rswind kernel: [ 2.301701] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Aug 16 21:25:06 rswind kernel: [ 2.302157] sda: sda1 sda2
Aug 16 21:25:06 rswind kernel: [ 2.324860] sd 0:0:0:0: [sda] Attached SCSI disk
Aug 16 21:25:06 rswind kernel: [ 2.526080] EXT4-fs (sda2): INFO: recovery required on readonly filesystem
Aug 16 21:25:06 rswind kernel: [ 2.526092] EXT4-fs (sda2): write access will be enabled during recovery
Aug 16 21:25:06 rswind kernel: [ 2.598912] EXT4-fs (sda2): recovery complete
Aug 16 21:25:06 rswind kernel: [ 2.603153] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
Aug 16 21:25:06 rswind kernel: [ 2.934752] scsi 4:0:0:0: Direct-Access Generic- Multi-Card 1.00 PQ: 0 ANSI: 0 CCS
Aug 16 21:25:06 rswind kernel: [ 2.935968] sd 4:0:0:0: Attached scsi generic sg1 type 0
Aug 16 21:25:06 rswind kernel: [ 2.939785] sd 4:0:0:0: [sdb] Attached SCSI removable disk
Aug 16 21:25:06 rswind kernel: [ 4.827701] Adding 1998844k swap on /dev/sda1. Priority:-1 extents:1 across:1998844k
Aug 16 21:25:06 rswind kernel: [ 5.037169] EXT4-fs (sda2): warning: maximal mount count reached, running e2fsck is recommended
Aug 16 21:25:06 rswind kernel: [ 5.143705] EXT4-fs (sda2): re-mounted. Opts: errors=remount-ro
Aug 16 21:25:06 rswind kernel: [ 5.201679] udev: starting version 151
Aug 16 21:25:06 rswind kernel: [ 5.206076] BUG: scheduling while atomic: init/341/0x10000001
Aug 16 21:25:06 rswind kernel: [ 5.206136] Modules linked in: usb_storage ahci libahci r8169 mii
Aug 16 21:25:06 rswind kernel: [ 5.206155] Pid: 341, comm: init Not tainted 2.6.35-02063502-generic #02063502
Aug 16 21:25:06 rswind kernel: [ 5.206160] Call Trace:
Aug 16 21:25:06 rswind kernel: [ 5.206179] [<c013fd15>] __schedule_bug+0x65/0x70
Aug 16 21:25:06 rswind kernel: [ 5.206190] [<c05c6a9e>] schedule+0x42e/0x5b0
Aug 16 21:25:06 rswind kernel: [ 5.206199] [<c016e510>] ? sched_clock_local+0xf0/0x190
Aug 16 21:25:06 rswind kernel: [ 5.206208] [<c0134ae3>] ? kmap_atomic_prot+0xb3/0xd0
Aug 16 21:25:06 rswind kernel: [ 5.206217] [<c01e054c>] ? prep_new_page+0xbc/0x110
Aug 16 21:25:06 rswind kernel: [ 5.206226] [<c014a55b>] __cond_resched+0x1b/0x30
Aug 16 21:25:06 rswind kernel: [ 5.206234] [<c05c6d45>] _cond_resched+0x25/0x30
Aug 16 21:25:06 rswind kernel: [ 5.206243] [<c020e5ed>] kmem_cache_alloc+0x9d/0x100
Aug 16 21:25:06 rswind kernel: [ 5.206253] [<c01fc5bf>] ? anon_vma_prepare+0x10f/0x140
Aug 16 21:25:06 rswind kernel: [ 5.206260] [<c01fc5bf>] anon_vma_prepare+0x10f/0x140
Aug 16 21:25:06 rswind kernel: [ 5.206270] [<c01f863d>] expand_downwards+0x1d/0xb0
Aug 16 21:25:06 rswind kernel: [ 5.206278] [<c01f86dd>] expand_stack+0xd/0x10
Aug 16 21:25:06 rswind kernel: [ 5.206286] [<c01f34fd>] do_anonymous_page+0x2dd/0x2f0
Aug 16 21:25:06 rswind kernel: [ 5.206294] [<c01f6462>] handle_mm_fault+0x262/0x2c0
Aug 16 21:25:06 rswind kernel: [ 5.206302] [<c01f8705>] ? find_extend_vma+0x25/0x70
Aug 16 21:25:06 rswind kernel: [ 5.206310] [<c01f6614>] __get_user_pages+0x154/0x420
Aug 16 21:25:06 rswind kernel: [ 5.206319] [<c01f6984>] get_user_pages+0x54/0x70
Aug 16 21:25:06 rswind kernel: [ 5.206329] [<c021ef25>] get_arg_page+0x55/0xb0
Aug 16 21:25:06 rswind kernel: [ 5.206338] [<c0355c30>] ? strnlen_user+0x30/0x60
Aug 16 21:25:06 rswind kernel: [ 5.206346] [<c021f067>] copy_strings+0xe7/0x190
Aug 16 21:25:06 rswind kernel: [ 5.206354] [<c021f139>] copy_strings_kernel+0x29/0x40
Aug 16 21:25:06 rswind kernel: [ 5.206362] [<c0220f4e>] do_execve+0x1ee/0x2b0
Aug 16 21:25:06 rswind kernel: [ 5.206370] [<c0109bc7>] sys_execve+0x37/0x70
Aug 16 21:25:06 rswind kernel: [ 5.206378] [<c0102dae>] ptregs_execve+0x12/0x18
Aug 16 21:25:06 rswind kernel: [ 5.206386] [<c0102cdf>] ? sysenter_do_call+0x12/0x28
Aug 16 21:25:06 rswind kernel: [ 7.165264] Linux agpgart interface v0.103
Aug 16 21:25:06 rswind kernel: [ 7.196518] intel_rng: FWH not detected
Aug 16 21:25:06 rswind kernel: [ 7.465045] agpgart-intel 0000:00:00.0: Intel 945GME Chipset
Aug 16 21:25:06 rswind kernel: [ 7.465738] agpgart-intel 0000:00:00.0: detected 7932K stolen memory
Aug 16 21:25:06 rswind kernel: [ 7.467017] r8187se: module is from the staging directory, the quality is unknown, you have been warned.
Aug 16 21:25:06 rswind kernel: [ 7.469672] agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xc0000000

[Leann Ogasawara (leannogasawara)]

Hi ReneS,

I believe a patch has been applied to the upstream kernel to resolve this issue:

commit 11ac552477e32835cb6970bf0a70c210807f5673
Author: Linus Torvalds <email address hidden>
Date: Sat Aug 14 11:44:56 2010 -0700

    mm: fix page table unmap for stack guard page properly

I've applied this patch to the latest Maverick kernel and built a test kernels for i386 and amd64. Could you please test and let me know if this resolves the issue you're seeing here? Thanks in advance.

http://people.canonical.com/~ogasawara/lp618846/

[ReneS (mail-03146f06)]

I am on it. Will try asap.

[ReneS (mail-03146f06)]

Works for me. Problem is gone. Machine comes up cleanly and worked well. No signs of the previous problems. Thanks!

[Leann Ogasawara (leannogasawara)]

Thanks for the quick turn around in testing, much appreciated. Glad to hear this indeed resolves the issue. I've committed the fix to the Maverick kernel. It should be included in the next upload (I'll likely upload tomorrow, so then give it a day or so to build and propagate through the archive). In the mean time, I'd just keep using the test kernel. Thanks again.

[Leann Ogasawara (leannogasawara)]

Fix Released as of linux-2.6.35-17.23. Thanks.