I just tried out 2.6.19-rc3-git7 here, and managed to get an "inconsistent lock state" traceback during boot time (with appropriate lock debugging stuff enabled). System has a few libata devices, and the traceback is from scsi_device_unbusy. dmesg output follows, kernel .config is attached. Cheers Linux version 2.6.19-rc3-git7-ml (root@host59) (gcc version 4.1.0 (SUSE Linux)) #3 SMP Mon Oct 30 09:23:39 EST 2006 BIOS-provided physical RAM map: BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved) BIOS-e820: 0000000000100000 - 000000003e7a0000 (usable) BIOS-e820: 000000003e7a0000 - 000000003e7ae000 (ACPI data) BIOS-e820: 000000003e7ae000 - 000000003e7e0000 (ACPI NVS) BIOS-e820: 000000003e7e0000 - 000000003e800000 (reserved) BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved) 103MB HIGHMEM available. 896MB LOWMEM available. found SMP MP-table at 000ff780 Entering add_active_range(0, 0, 255904) 0 entries of 256 used Zone PFN ranges: DMA 0 -> 4096 Normal 4096 -> 229376 HighMem 229376 -> 255904 early_node_map[1] active PFN ranges 0: 0 -> 255904 On node 0 totalpages: 255904 DMA zone: 32 pages used for memmap DMA zone: 0 pages reserved DMA zone: 4064 pages, LIFO batch:0 Normal zone: 1760 pages used for memmap Normal zone: 223520 pages, LIFO batch:31 HighMem zone: 207 pages used for memmap HighMem zone: 26321 pages, LIFO batch:7 DMI 2.4 present. ACPI: RSDP (v002 ACPIAM ) @ 0x000fa9a0 ACPI: XSDT (v001 A M I OEMXSDT 0x08000604 MSFT 0x00000097) @ 0x3e7a0100 ACPI: FADT (v003 A M I OEMFACP 0x08000604 MSFT 0x00000097) @ 0x3e7a0290 ACPI: MADT (v001 A M I OEMAPIC 0x08000604 MSFT 0x00000097) @ 0x3e7a0390 ACPI: MCFG (v001 A M I OEMMCFG 0x08000604 MSFT 0x00000097) @ 0x3e7a0400 ACPI: OEMB (v001 A M I AMI_OEM 0x08000604 MSFT 0x00000097) @ 0x3e7ae040 ACPI: DSDT (v001 A0518 A0518000 0x00000000 INTL 0x20060113) @ 0x00000000 ACPI: PM-Timer IO Port: 0x808 ACPI: Local APIC address 0xfee00000 ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) Processor #0 6:15 APIC version 20 ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) Processor #1 6:15 APIC version 20 ACPI: LAPIC (acpi_id[0x03] lapic_id[0x82] disabled) ACPI: LAPIC (acpi_id[0x04] lapic_id[0x83] disabled) ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) ACPI: IRQ0 used by override. ACPI: IRQ2 used by override. ACPI: IRQ9 used by override. Enabling APIC mode: Flat. Using 1 I/O APICs Using ACPI (MADT) for SMP configuration information Allocating PCI resources starting at 40000000 (gap: 3e800000:c0600000) Detected 1866.796 MHz processor. Built 1 zonelists. Total pages: 253905 Kernel command line: root=/dev/sda2 vga=0x31a resume=/dev/sda1 mapped APIC to ffffd000 (fee00000) mapped IOAPIC to ffffc000 (fec00000) Enabling fast FPU save and restore... done. Enabling unmasked SIMD FPU exception support... done. Initializing CPU#0 PID hash table entries: 4096 (order: 12, 16384 bytes) Console: colour dummy device 80x25 Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar ... MAX_LOCKDEP_SUBCLASSES: 8 ... MAX_LOCK_DEPTH: 30 ... MAX_LOCKDEP_KEYS: 2048 ... CLASSHASH_SIZE: 1024 ... MAX_LOCKDEP_ENTRIES: 8192 ... MAX_LOCKDEP_CHAINS: 8192 ... CHAINHASH_SIZE: 4096 memory used by lock dependency info: 904 kB per task-struct memory footprint: 1200 bytes ------------------------ | Locking API testsuite: ---------------------------------------------------------------------------- | spin |wlock |rlock |mutex | wsem | rsem | -------------------------------------------------------------------------- A-A deadlock: ok | ok | ok | ok | ok | ok | A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | double unlock: ok | ok | ok | ok | ok | ok | initialize held: ok | ok | ok | ok | ok | ok | bad unlock order: ok | ok | ok | ok | ok | ok | -------------------------------------------------------------------------- recursive read-lock: | ok | | ok | recursive read-lock #2: | ok | | ok | mixed read-write-lock: | ok | | ok | mixed write-read-lock: | ok | | ok | -------------------------------------------------------------------------- hard-irqs-on + irq-safe-A/12: ok | ok | ok | soft-irqs-on + irq-safe-A/12: ok | ok | ok | hard-irqs-on + irq-safe-A/21: ok | ok | ok | soft-irqs-on + irq-safe-A/21: ok | ok | ok | sirq-safe-A => hirqs-on/12: ok | ok | ok | sirq-safe-A => hirqs-on/21: ok | ok | ok | hard-safe-A + irqs-on/12: ok | ok | ok | soft-safe-A + irqs-on/12: ok | ok | ok | hard-safe-A + irqs-on/21: ok | ok | ok | soft-safe-A + irqs-on/21: ok | ok | ok | hard-safe-A + unsafe-B #1/123: ok | ok | ok | soft-safe-A + unsafe-B #1/123: ok | ok | ok | hard-safe-A + unsafe-B #1/132: ok | ok | ok | soft-safe-A + unsafe-B #1/132: ok | ok | ok | hard-safe-A + unsafe-B #1/213: ok | ok | ok | soft-safe-A + unsafe-B #1/213: ok | ok | ok | hard-safe-A + unsafe-B #1/231: ok | ok | ok | soft-safe-A + unsafe-B #1/231: ok | ok | ok | hard-safe-A + unsafe-B #1/312: ok | ok | ok | soft-safe-A + unsafe-B #1/312: ok | ok | ok | hard-safe-A + unsafe-B #1/321: ok | ok | ok | soft-safe-A + unsafe-B #1/321: ok | ok | ok | hard-safe-A + unsafe-B #2/123: ok | ok | ok | soft-safe-A + unsafe-B #2/123: ok | ok | ok | hard-safe-A + unsafe-B #2/132: ok | ok | ok | soft-safe-A + unsafe-B #2/132: ok | ok | ok | hard-safe-A + unsafe-B #2/213: ok | ok | ok | soft-safe-A + unsafe-B #2/213: ok | ok | ok | hard-safe-A + unsafe-B #2/231: ok | ok | ok | soft-safe-A + unsafe-B #2/231: ok | ok | ok | hard-safe-A + unsafe-B #2/312: ok | ok | ok | soft-safe-A + unsafe-B #2/312: ok | ok | ok | hard-safe-A + unsafe-B #2/321: ok | ok | ok | soft-safe-A + unsafe-B #2/321: ok | ok | ok | hard-irq lock-inversion/123: ok | ok | ok | soft-irq lock-inversion/123: ok | ok | ok | hard-irq lock-inversion/132: ok | ok | ok | soft-irq lock-inversion/132: ok | ok | ok | hard-irq lock-inversion/213: ok | ok | ok | soft-irq lock-inversion/213: ok | ok | ok | hard-irq lock-inversion/231: ok | ok | ok | soft-irq lock-inversion/231: ok | ok | ok | hard-irq lock-inversion/312: ok | ok | ok | soft-irq lock-inversion/312: ok | ok | ok | hard-irq lock-inversion/321: ok | ok | ok | soft-irq lock-inversion/321: ok | ok | ok | hard-irq read-recursion/123: ok | soft-irq read-recursion/123: ok | hard-irq read-recursion/132: ok | soft-irq read-recursion/132: ok | hard-irq read-recursion/213: ok | soft-irq read-recursion/213: ok | hard-irq read-recursion/231: ok | soft-irq read-recursion/231: ok | hard-irq read-recursion/312: ok | soft-irq read-recursion/312: ok | hard-irq read-recursion/321: ok | soft-irq read-recursion/321: ok | ------------------------------------------------------- Good, all 218 testcases passed! | --------------------------------- Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Memory: 1005060k/1023616k available (2443k kernel code, 17752k reserved, 1029k data, 268k init, 106112k highmem) virtual kernel memory layout: fixmap : 0xfff9d000 - 0xfffff000 ( 392 kB) pkmap : 0xff800000 - 0xffc00000 (4096 kB) vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB) lowmem : 0xc0000000 - 0xf8000000 ( 896 MB) .init : 0xc04bb000 - 0xc04fe000 ( 268 kB) .data : 0xc0362ff4 - 0xc046450c (1029 kB) .text : 0xc0100000 - 0xc0362ff4 (2443 kB) Checking if this processor honours the WP bit even in supervisor mode... Ok. Calibrating delay using timer specific routine.. 3736.91 BogoMIPS (lpj=7473831) Mount-cache hash table entries: 512 CPU: After generic identify, caps: bfebfbff 20100000 00000000 00000000 0000e3bd 00000000 00000001 monitor/mwait feature present. using mwait in idle threads. CPU: L1 I cache: 32K, L1 D cache: 32K CPU: L2 cache: 2048K CPU: Physical Processor ID: 0 CPU: Processor Core ID: 0 CPU: After all inits, caps: bfebfbff 20100000 00000000 00000940 0000e3bd 00000000 00000001 Intel machine check architecture supported. Intel machine check reporting enabled on CPU#0. Compat vDSO mapped to ffffe000. Checking 'hlt' instruction... OK. Freeing SMP alternatives: 12k freed ACPI: Core revision 20060707 CPU0: Intel(R) Core(TM)2 CPU 6300 @ 1.86GHz stepping 06 lockdep: not fixing up alternatives. Booting processor 1/1 eip 2000 Initializing CPU#1 Calibrating delay using timer specific routine.. 3733.62 BogoMIPS (lpj=7467242) CPU: After generic identify, caps: bfebfbff 20100000 00000000 00000000 0000e3bd 00000000 00000001 monitor/mwait feature present. CPU: L1 I cache: 32K, L1 D cache: 32K CPU: L2 cache: 2048K CPU: Physical Processor ID: 0 CPU: Processor Core ID: 1 CPU: After all inits, caps: bfebfbff 20100000 00000000 00000940 0000e3bd 00000000 00000001 Intel machine check architecture supported. Intel machine check reporting enabled on CPU#1. CPU1: Intel(R) Core(TM)2 CPU 6300 @ 1.86GHz stepping 06 Total of 2 processors activated (7470.53 BogoMIPS). ENABLING IO-APIC IRQs ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1 checking TSC synchronization across 2 CPUs: passed. Brought up 2 CPUs migration_cost=29 checking if image is initramfs... it is Freeing initrd memory: 2390k freed NET: Registered protocol family 16 ACPI: bus type pci registered PCI: BIOS Bug: MCFG area at e0000000 is not E820-reserved PCI: Not using MMCONFIG. PCI: PCI BIOS revision 3.00 entry at 0xf0031, last bus=6 PCI: Using configuration type 1 Setting up standard PCI resources ACPI: Interpreter enabled ACPI: Using IOAPIC for interrupt routing ACPI: PCI Root Bridge [PCI0] (0000:00) PCI: Probing PCI hardware (bus 00) Boot video device is 0000:00:02.0 PCI quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO PCI quirk: region 0480-04bf claimed by ICH6 GPIO PCI: Transparent bridge - 0000:00:1e.0 ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P2._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P1._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P8._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P9._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P4._PRT] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 *11 12 14 15) ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *10 11 12 14 15) ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 10 11 12 14 15) ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 10 11 12 14 *15) ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 *11 12 14 15) ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LNKG] (IRQs *3 4 5 6 7 10 11 12 14 15) ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 10 11 12 *14 15) Linux Plug and Play Support v0.97 (c) Adam Belay pnp: PnP ACPI init pnp: PnP ACPI: found 15 devices SCSI subsystem initialized PCI: Using ACPI for IRQ routing PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report pnp: 00:07: ioport range 0x290-0x297 has been reserved PCI: Ignore bogus resource 6 [0:0] of 0000:00:02.0 PCI: Bridge: 0000:00:01.0 IO window: disabled. MEM window: disabled. PREFETCH window: afd00000-afdfffff PCI: Bridge: 0000:00:1c.0 IO window: disabled. MEM window: disabled. PREFETCH window: afe00000-afefffff PCI: Bridge: 0000:00:1c.4 IO window: b000-bfff MEM window: ff600000-ff6fffff PREFETCH window: disabled. PCI: Bridge: 0000:00:1c.5 IO window: a000-afff MEM window: ff500000-ff5fffff PREFETCH window: disabled. PCI: Bridge: 0000:05:04.0 IO window: disabled. MEM window: disabled. PREFETCH window: aff00000-bfefffff PCI: Bridge: 0000:00:1e.0 IO window: disabled. MEM window: ff700000-ff7fffff PREFETCH window: aff00000-bfefffff ACPI: PCI Interrupt 0000:00:01.0[A] -> GSI 16 (level, low) -> IRQ 16 PCI: Setting latency timer of device 0000:00:01.0 to 64 ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 17 (level, low) -> IRQ 17 PCI: Setting latency timer of device 0000:00:1c.0 to 64 ACPI: PCI Interrupt 0000:00:1c.4[A] -> GSI 17 (level, low) -> IRQ 17 PCI: Setting latency timer of device 0000:00:1c.4 to 64 ACPI: PCI Interrupt 0000:00:1c.5[B] -> GSI 16 (level, low) -> IRQ 16 PCI: Setting latency timer of device 0000:00:1c.5 to 64 PCI: Setting latency timer of device 0000:00:1e.0 to 64 NET: Registered protocol family 2 IP route cache hash table entries: 32768 (order: 5, 131072 bytes) TCP established hash table entries: 131072 (order: 10, 4194304 bytes) TCP bind hash table entries: 65536 (order: 9, 2097152 bytes) TCP: Hash tables configured (established 131072 bind 65536) TCP reno registered highmem bounce pool size: 64 pages Total HugeTLB memory allocated, 0 io scheduler noop registered io scheduler anticipatory registered io scheduler deadline registered io scheduler cfq registered (default) vesafb: framebuffer at 0xd0000000, mapped to 0xf8880000, using 5120k, total 7616k vesafb: mode is 1280x1024x16, linelength=2560, pages=1 vesafb: protected mode interface info at 00ff:44f0 vesafb: scrolling: redraw vesafb: Truecolor: size=0:5:6:5, shift=0:11:5:0 Console: switching to colour frame buffer device 160x64 fb0: VESA VGA frame buffer device vga16fb: initializing vga16fb: mapped to 0xc00a0000 fb1: VGA16 VGA frame buffer device isapnp: Scanning for PnP cards... isapnp: No Plug & Play device found Real Time Clock Driver v1.12ac Linux agpgart interface v0.101 (c) Dave Jones agpgart: Detected an Intel 965G Chipset. agpgart: Detected 7676K stolen memory. agpgart: AGP aperture is 256M @ 0xd0000000 intelfb: Framebuffer driver for Intel(R) 830M/845G/852GM/855GM/865G/915G/915GM/945G/945GM chipsets intelfb: Version 0.9.4 Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A RAMDISK driver initialized: 16 RAM disks of 64000K size 1024 blocksize loop: loaded (max 8 devices) libata version 2.00 loaded. ahci 0000:03:00.0: version 2.0 ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 16 (level, low) -> IRQ 16 PCI: Setting latency timer of device 0000:03:00.0 to 64 ahci 0000:03:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode ahci 0000:03:00.0: flags: 64bit ncq pm led clo pmp pio slum part ata1: SATA max UDMA/133 cmd 0xF880C100 ctl 0x0 bmdma 0x0 irq 16 ata2: SATA max UDMA/133 cmd 0xF880C180 ctl 0x0 bmdma 0x0 irq 16 scsi0 : ahci ata1: SATA link down (SStatus 0 SControl 300) scsi1 : ahci ata2: softreset failed (1st FIS failed) ata2: softreset failed, retrying in 5 secs ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) ata2.00: ATA-6, max UDMA/133, 72303840 sectors: LBA48 ata2.00: ata2: dev 0 multi count 0 ata2.00: applying bridge limits ata2.00: configured for UDMA/100 scsi 1:0:0:0: Direct-Access ATA WDC WD360GD-50GH 37.0 PQ: 0 ANSI: 5 SCSI device sda: 72303840 512-byte hdwr sectors (37020 MB) sda: Write Protect is off sda: Mode Sense: 00 3a 00 00 SCSI device sda: drive cache: write back SCSI device sda: 72303840 512-byte hdwr sectors (37020 MB) sda: Write Protect is off sda: Mode Sense: 00 3a 00 00 SCSI device sda: drive cache: write back sda: sda1 sda2 sd 1:0:0:0: Attached scsi disk sda sd 1:0:0:0: Attached scsi generic sg0 type 0 PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12 serio: i8042 KBD port at 0x60,0x64 irq 1 serio: i8042 AUX port at 0x60,0x64 irq 12 mice: PS/2 mouse device common for all mice input: PC Speaker as /class/input/input0 input: AT Translated Set 2 keyboard as /class/input/input1 TCP cubic registered NET: Registered protocol family 1 Starting balanced_irq Using IPI Shortcut mode Time: tsc clocksource has been installed. Freeing unused kernel memory: 268k freed ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ AMI] OemTableId [ CPU1PM] [20060707] ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ AMI] OemTableId [ CPU2PM] [20060707] ACPI: Getting cpuindex for acpiid 0x3 ACPI: Getting cpuindex for acpiid 0x4 input: ImPS/2 Generic Wheel Mouse as /class/input/input2 BIOS EDD facility v0.16 2004-Jun-25, 2 devices found ata_piix 0000:00:1f.2: version 2.00ac6 ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 19 (level, low) -> IRQ 18 PCI: Setting latency timer of device 0000:00:1f.2 to 64 ata3: SATA max UDMA/133 cmd 0xE880 ctl 0xE802 bmdma 0xE080 irq 18 ata4: SATA max UDMA/133 cmd 0xE480 ctl 0xE402 bmdma 0xE088 irq 18 scsi2 : ata_piix ATA: abnormal status 0x7F on port 0xE887 scsi3 : ata_piix ata4.00: ATA-7, max UDMA/133, 625142448 sectors: LBA48 NCQ (depth 0/32) ata4.00: ata4: dev 0 multi count 16 ata4.00: configured for UDMA/133 scsi 3:0:0:0: Direct-Access ATA Maxtor 7B320S0 BANC PQ: 0 ANSI: 5 SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB) sdb: Write Protect is off sdb: Mode Sense: 00 3a 00 00 SCSI device sdb: drive cache: write through SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB) sdb: Write Protect is off sdb: Mode Sense: 00 3a 00 00 SCSI device sdb: drive cache: write through sdb: unknown partition table sd 3:0:0:0: Attached scsi disk sdb sd 3:0:0:0: Attached scsi generic sg1 type 0 ata_piix 0000:00:1f.5: MAP [ P0 P2 P1 P3 ] ACPI: PCI Interrupt 0000:00:1f.5[B] -> GSI 19 (level, low) -> IRQ 18 PCI: Setting latency timer of device 0000:00:1f.5 to 64 ata5: SATA max UDMA/133 cmd 0xD080 ctl 0xD002 bmdma 0xC800 irq 18 ata6: SATA max UDMA/133 cmd 0xCC00 ctl 0xC882 bmdma 0xC808 irq 18 scsi4 : ata_piix ATA: abnormal status 0x7F on port 0xD087 scsi5 : ata_piix ATA: abnormal status 0x7F on port 0xCC07 warning: process `ls' used the removed sysctl system call ReiserFS: sda2: found reiserfs format "3.6" with standard journal ReiserFS: sda2: using ordered data mode ReiserFS: sda2: journal params: device sda2, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: sda2: checking transaction log (sda2) ReiserFS: sda2: Using r5 hash to sort names warning: process `showconsole' used the removed sysctl system call Adding 1518100k swap on /dev/sda1. Priority:-1 extents:1 across:1518100k warning: process `showconsole' used the removed sysctl system call warning: process `ls' used the removed sysctl system call device-mapper: ioctl: 4.10.0-ioctl (2006-09-14) initialised: dm-devel@redhat.com warning: process `showconsole' used the removed sysctl system call ACPI: Power Button (FF) [PWRF] ACPI: Power Button (CM) [PWRB] ================================= [ INFO: inconsistent lock state ] 2.6.19-rc3-git7-ml #3 --------------------------------- inconsistent {in-softirq-W} -> {softirq-on-W} usage. startproc/4046 [HC0[0]:SC0[0]:HE1:SE1] takes: (&q->__queue_lock){-+..}, at: [] cfq_set_request+0x351/0x3b0 {in-softirq-W} state was registered at: [] mark_lock+0x81/0x5f0 [] __lock_acquire+0x660/0xc10 [] lock_acquire+0x5d/0x80 [] _spin_lock+0x29/0x40 [] scsi_device_unbusy+0x64/0x90 [] scsi_finish_command+0x1c/0xa0 [] blk_done_softirq+0x62/0x70 [] __do_softirq+0x87/0x100 [] do_softirq+0x55/0x60 [] ksoftirqd+0x7c/0xd0 [] kthread+0xf6/0x100 [] kernel_thread_helper+0x7/0x18 [] 0xffffffff irq event stamp: 3331 hardirqs last enabled at (3331): [] kmem_cache_alloc+0x6d/0xa0 hardirqs last disabled at (3330): [] kmem_cache_alloc+0x1f/0xa0 softirqs last enabled at (3012): [] do_softirq+0x55/0x60 softirqs last disabled at (2971): [] do_softirq+0x55/0x60 other info that might help us debug this: no locks held by startproc/4046. stack backtrace: [] dump_trace+0x192/0x1c0 [] show_trace_log_lvl+0x18/0x30 [] show_trace+0xf/0x20 [] dump_stack+0x15/0x20 [] print_usage_bug+0x251/0x270 [] mark_lock+0x4b7/0x5f0 [] __lock_acquire+0x67e/0xc10 [] lock_acquire+0x5d/0x80 [] _spin_lock+0x29/0x40 [] cfq_set_request+0x351/0x3b0 [] elv_set_request+0x1c/0x40 [] get_request+0x23f/0x270 [] get_request_wait+0x27/0x120 [] __make_request+0x5a/0x350 [] generic_make_request+0x16f/0x220 [] submit_bio+0x64/0x110 [] mpage_bio_submit+0x19/0x20 [] mpage_readpages+0x105/0x140 [] __do_page_cache_readahead+0x17f/0x260 [] blockable_page_cache_readahead+0x72/0xd0 [] page_cache_readahead+0x135/0x1e0 [] do_generic_mapping_read+0x55e/0x5a0 [] generic_file_aio_read+0x101/0x270 [] do_sync_read+0xd5/0x120 [] vfs_read+0xa1/0x160 [] sys_read+0x41/0x70 [] sysenter_past_esp+0x56/0x8d [] 0xb7efd410 ======================= IA-32 Microcode Update Driver: v1.14a pvm:~#