* 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert)
@ 2011-11-23 10:20 Meelis Roos
0 siblings, 0 replies; 4+ messages in thread
From: Meelis Roos @ 2011-11-23 10:20 UTC (permalink / raw)
To: Linux Kernel list, linux-scsi
Hello,
While trying 3.2.0-rc2-00143-ga767835 on Sun Ultra 10 (sparc64) with
Adaptec SCSI controller, I can consistently get the below BUG shortly
after bootup. Another machine, Sun Ultra 5 with IDE disk, works fine
(config might also differ in other details than ide/scsi).
PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
PROMLIB: Root node compatible:
Initializing cgroup subsys cpu
Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
debug: ignoring loglevel setting.
bootconsole [earlyprom0] enabled
ARCH: SUN4U
Ethernet address: 08:00:20:9e:82:fd
Kernel: Using 2 locked TLB entries for main kernel image.
Remapping the kernel... done.
OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
PROM: Built device tree with 49735 bytes of memory.
Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
Memory hole size: 0MB
[0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
[0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
Zone PFN ranges:
Normal 0x00000000 -> 0x0000ff94
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
0: 0x00000000 -> 0x0000ff7f
0: 0x0000ff88 -> 0x0000ff94
On node 0 totalpages: 65419
Normal zone: 512 pages used for memmap
Normal zone: 0 pages reserved
Normal zone: 64907 pages, LIFO batch:15
Booting Linux...
CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
CPU CAPS: [vis]
pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
pcpu-alloc: [0] 0
Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
PID hash table entries: 2048 (order: 1, 16384 bytes)
Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
NR_IRQS:255
clocksource: mult[3555555] shift[24]
clockevent: mult[4ccccccd] shift[32]
Console: colour dummy device 80x25
console [tty0] enabled, bootconsole disabled
PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
PROMLIB: Root node compatible:
Initializing cgroup subsys cpu
Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
debug: ignoring loglevel setting.
bootconsole [earlyprom0] enabled
ARCH: SUN4U
Ethernet address: 08:00:20:9e:82:fd
Kernel: Using 2 locked TLB entries for main kernel image.
Remapping the kernel... done.
OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
PROM: Built device tree with 49735 bytes of memory.
Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
Memory hole size: 0MB
[0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
[0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
Zone PFN ranges:
Normal 0x00000000 -> 0x0000ff94
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
0: 0x00000000 -> 0x0000ff7f
0: 0x0000ff88 -> 0x0000ff94
On node 0 totalpages: 65419
Normal zone: 512 pages used for memmap
Normal zone: 0 pages reserved
Normal zone: 64907 pages, LIFO batch:15
Booting Linux...
CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
CPU CAPS: [vis]
pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
pcpu-alloc: [0] 0
Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
PID hash table entries: 2048 (order: 1, 16384 bytes)
Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
NR_IRQS:255
clocksource: mult[3555555] shift[24]
clockevent: mult[4ccccccd] shift[32]
Console: colour dummy device 80x25
console [tty0] enabled, bootconsole disabled
Calibrating delay using timer specific routine.. 601.00 BogoMIPS (lpj=3005039)
pid_max: default: 32768 minimum: 301
Mount-cache hash table entries: 512
NET: Registered protocol family 16
/pci@1f,0: PCI IO[1fe02000000] MEM[1ff00000000]
/pci@1f,0: SABRE PCI Bus Module ver[0:0]
PCI: Scanning PBM /pci@1f,0
pci 0000:02:02.0: supports D1 D2
pci 0000:02:02.0: PME# supported from D0 D1 D2 D3hot
pci 0000:02:02.0: PME# disabled
bio: create slab <bio-0> at 0
vgaarb: device added: PCI:0000:01:02.0,decodes=io+mem,owns=none,locks=none
vgaarb: loaded
vgaarb: bridge control possible 0000:01:02.0
SCSI subsystem initialized
/pci@1f,0/pci@1,1/ebus@1/eeprom@14,0: Mostek regs at 0x1fff1000000
AUXIO: Found device at /pci@1f,0/pci@1,1/ebus@1/auxio@14,726000
Switching to clocksource tick
NET: Registered protocol family 2
IP route cache hash table entries: 4096 (order: 2, 32768 bytes)
TCP established hash table entries: 16384 (order: 5, 262144 bytes)
TCP bind hash table entries: 16384 (order: 4, 131072 bytes)
TCP: Hash tables configured (established 16384 bind 16384)
TCP reno registered
UDP hash table entries: 256 (order: 0, 8192 bytes)
UDP-Lite hash table entries: 256 (order: 0, 8192 bytes)
NET: Registered protocol family 1
PCI: CLS 64 bytes, default 64
power: Control reg at 1fff1724000
VFS: Disk quotas dquot_6.5.2
Dquot-cache hash table entries: 1024 (order 0, 8192 bytes)
msgmni has been set to 993
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
io scheduler noop registered
io scheduler deadline registered
io scheduler cfq registered (default)
start plist test
end plist test
PCI: Enabling device: (0000:01:02.0), cmd 82
atyfb: 3D RAGE II+ (Mach64 GT) [0x4754 rev 0x9a]
atyfb: 2M SGRAM (1:1), 14.31818 MHz XTAL, 200 MHz PLL, 67 Mhz MCLK, 67 MHz XCLK
Console: switching to colour frame buffer device 80x30
atyfb: fb0: ATY Mach64 frame buffer device on PCI
/SUNW,ffb@1e,0: FFB at 000001fc00000000, type 51, DAC pnum[236e] rev[10] manuf_rev[1]
/pci@1f,0/pci@1,1/ebus@1/su@14,3083f8: Keyboard port at 1fff13083f8, irq 6
/pci@1f,0/pci@1,1/ebus@1/su@14,3062f8: Mouse port at 1fff13062f8, irq 7
f0061c64: ttyS0 at MMIO 0x1fff1400000 (irq = 5) is a SAB82532 V3.2
Console: ttyS0 (SAB82532)
console [ttyS0] enabled
f0061c64: ttyS1 at MMIO 0x1fff1400040 (irq = 5) is a SAB82532 V3.2
Floppy drive(s): fd0 is 1.44M
FDC 0 is a National Semiconductor PC87306
scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
<Adaptec 2940 Ultra SCSI adapter>
aic7880: Ultra Wide Channel A, SCSI Id=7, 16/253 SCBs
scsi 0:0:0:0: Direct-Access QUANTUM ATLAS IV 18 WLS 0909 PQ: 0 ANSI: 3
scsi0:A:0:0: Tagged Queuing enabled. Depth 253
scsi target0:0:0: Beginning Domain Validation
scsi target0:0:0: wide asynchronous
scsi target0:0:0: FAST-10 WIDE SCSI 20.0 MB/s ST (100 ns, offset 8)
scsi target0:0:0: Domain Validation skipping write tests
scsi target0:0:0: Ending Domain Validation
sd 0:0:0:0: [sda] 35885168 512-byte logical blocks: (18.3 GB/17.1 GiB)
PCI: Enabling device: (0000:01:01.1), cmd 2
sunhme.c:v3.10 August 26, 2008 David S. Miller (davem@davemloft.net)
eth0: HAPPY MEAL (PCI/CheerIO) 10/100BaseT Ethernet 08:00:20:9e:82:fd
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: e3 00 10 08
mousedev: PS/2 mouse device common for all mice
sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
rtc-m48t59 rtc-m48t59.0: rtc core: registered m48t59 as rtc0
TCP cubic registered
NET: Registered protocol family 17
Registering the dns_resolver key type
registered taskstats version 1
rtc-m48t59 rtc-m48t59.0: setting system clock to 2011-11-21 11:41:58 UTC (1321875718)
sda: sda1 sda2 sda3 sda4
sd 0:0:0:0: [sda] Attached SCSI disk
input: Sun Mouse as /devices/root/f005f9c0/f00601b4/f0061504/f0064df4/serio1/input/input0
EXT3-fs (sda4): error: couldn't mount because of unsupported optional features (240)
EXT2-fs (sda4): error: couldn't mount because of unsupported optional features (244)
EXT4-fs (sda4): INFO: recovery required on readonly filesystem
EXT4-fs (sda4): write access will be enabled during recovery
EXT4-fs (sda4): recovery complete
EXT4-fs (sda4): mounted filesystem with ordered data mode. Opts: (null)
VFS: Mounted root (ext4 filesystem) readonly on device 8:4.
8139too: 8139too Fast Ethernet driver 0.9.28
PCI: Enabling device: (0000:02:02.0), cmd 3
8139too 0000:02:02.0: eth1: RealTek RTL8139 at 0x1ff00020000, 00:10:b5:a3:e4:a6, IRQ 16
/pci@1f,0/pci@1,1/ebus@1/flashprom@10,0: OBP Flash, RD 1fff0000000[100000] WR 1fff0000000[100000]
libata version 3.00 loaded.
scsi1 : pata_cmd64x
scsi2 : pata_cmd64x
ata1: PATA max MWDMA2 cmd 0x1fe02c00000 ctl 0x1fe02c00008 bmdma 0x1fe02c00020 irq 14
ata2: PATA max MWDMA2 cmd 0x1fe02c00010 ctl 0x1fe02c00018 bmdma 0x1fe02c00028 irq 14
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
Adding 1052248k swap on /dev/sda2. Priority:-1 extents:1 across:1052248k
EXT4-fs (sda4): re-mounted. Opts: (null)
eth0: Link is up using internal transceiver at 100Mb/s, Full Duplex.
eth0: no IPv6 routers present
kernel BUG at block/blk-core.c:1000!
\|/ ____ \|/
"@'/ .. \`@"
/_| \__/ |_\
\__U_/
swapper(0): Kernel bad sw trap 5 [#1]
TSTATE: 0000008080e01602 TPC: 00000000005c3380 TNPC: 00000000005c3384 Y: 00000000 Not tainted
TPC: <blk_requeue_request+0x60/0x80>
g0: 0000000000000003 g1: 0000000000872000 g2: 0000000000000001 g3: ffffffffffffffd8
g4: 0000000000869b50 g5: f7ddef20f7767b60 g6: 0000000000860000 g7: 0000000000001000
o0: 0000000000000028 o1: 0000000000816440 o2: 00000000000003e8 o3: 00000000ffffa86e
o4: fffff8001f00cb60 o5: 0000000000816440 sp: fffff8001fefb471 ret_pc: 00000000005c3378
RPC: <blk_requeue_request+0x58/0x80>
l0: 00000000fffc00f0 l1: 0000000000883790 l2: 0000000000000001 l3: fffff8001f0060c0
l4: fffff8001f0020c0 l5: 0000000000000000 l6: 00000000008a2e18 l7: fffffffffffffff8
i0: fffff8001f2d3100 i1: fffff8001f329a20 i2: 000000000091d56c i3: 000000000091d400
i4: 0000000000000001 i5: 0000000000000000 i6: fffff8001fefb521 i7: 000000000065dc10
I7: <__scsi_queue_insert+0xb0/0x100>
Call Trace:
[000000000065dc10] __scsi_queue_insert+0xb0/0x100
[00000000005c812c] blk_done_softirq+0x6c/0xa0
[000000000045a530] __do_softirq+0x90/0x120
[000000000042b054] do_softirq+0x74/0xa0
[000000000045a82c] irq_exit+0x8c/0xa0
[000000000042af9c] handler_irq+0x9c/0xe0
[00000000004208b4] tl0_irq5+0x14/0x20
[0000000000439484] touch_nmi_watchdog+0x4/0x40
[00000000008a8788] start_kernel+0x318/0x328
[000000000074af88] tlb_fixup_done+0x80/0x88
[0000000000000000] (null)
Disabling lock debugging due to kernel taint
Caller[000000000065dc10]: __scsi_queue_insert+0xb0/0x100
Caller[00000000005c812c]: blk_done_softirq+0x6c/0xa0
Caller[000000000045a530]: __do_softirq+0x90/0x120
Caller[000000000042b054]: do_softirq+0x74/0xa0
Caller[000000000045a82c]: irq_exit+0x8c/0xa0
Caller[000000000042af9c]: handler_irq+0x9c/0xe0
Caller[00000000004208b4]: tl0_irq5+0x14/0x20
Caller[000000000042b828]: cpu_idle+0x28/0x60
Caller[00000000008a8788]: start_kernel+0x318/0x328
Caller[000000000074af88]: tlb_fixup_done+0x80/0x88
Caller[0000000000000000]: (null)
Instruction DUMP: 921023e8 7ff99282 90122040 <91d02005> 30680007 01000000 01000000 01000000 01000000
Kernel panic - not syncing: Aiee, killing interrupt handler!
Call Trace:
[00000000004586ec] do_exit+0x2cc/0x300
[00000000004274c0] die_if_kernel+0x180/0x260
[00000000004282d4] bad_trap+0xd4/0xe0
[00000000004220b0] tl0_resv104+0x30/0xa0
[00000000005c3380] blk_requeue_request+0x60/0x80
[000000000065dc10] __scsi_queue_insert+0xb0/0x100
[00000000005c812c] blk_done_softirq+0x6c/0xa0
[000000000045a530] __do_softirq+0x90/0x120
[000000000042b054] do_softirq+0x74/0xa0
[000000000045a82c] irq_exit+0x8c/0xa0
[000000000042af9c] handler_irq+0x9c/0xe0
[00000000004208b4] tl0_irq5+0x14/0x20
[0000000000439484] touch_nmi_watchdog+0x4/0x40
[00000000008a8788] start_kernel+0x318/0x328
[000000000074af88] tlb_fixup_done+0x80/0x88
[0000000000000000] (null)
Press Stop-A (L1-A) to return to the boot prom
--
Meelis Roos (mroos@linux.ee)
^ permalink raw reply [flat|nested] 4+ messages in thread
* 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert)
@ 2011-11-23 10:24 Meelis Roos
2011-12-13 14:04 ` Meelis Roos
0 siblings, 1 reply; 4+ messages in thread
From: Meelis Roos @ 2011-11-23 10:24 UTC (permalink / raw)
To: Linux Kernel list, linux-scsi
(resetn with correct linux-scsi address, please do not reply to the
previous one)
Hello,
While trying 3.2.0-rc2-00143-ga767835 on Sun Ultra 10 (sparc64) with
Adaptec SCSI controller, I can consistently get the below BUG shortly
after bootup. Another machine, Sun Ultra 5 with IDE disk, works fine
(config might also differ in other details than ide/scsi).
PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
PROMLIB: Root node compatible:
Initializing cgroup subsys cpu
Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
debug: ignoring loglevel setting.
bootconsole [earlyprom0] enabled
ARCH: SUN4U
Ethernet address: 08:00:20:9e:82:fd
Kernel: Using 2 locked TLB entries for main kernel image.
Remapping the kernel... done.
OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
PROM: Built device tree with 49735 bytes of memory.
Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
Memory hole size: 0MB
[0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
[0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
Zone PFN ranges:
Normal 0x00000000 -> 0x0000ff94
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
0: 0x00000000 -> 0x0000ff7f
0: 0x0000ff88 -> 0x0000ff94
On node 0 totalpages: 65419
Normal zone: 512 pages used for memmap
Normal zone: 0 pages reserved
Normal zone: 64907 pages, LIFO batch:15
Booting Linux...
CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
CPU CAPS: [vis]
pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
pcpu-alloc: [0] 0
Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
PID hash table entries: 2048 (order: 1, 16384 bytes)
Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
NR_IRQS:255
clocksource: mult[3555555] shift[24]
clockevent: mult[4ccccccd] shift[32]
Console: colour dummy device 80x25
console [tty0] enabled, bootconsole disabled
PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
PROMLIB: Root node compatible:
Initializing cgroup subsys cpu
Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
debug: ignoring loglevel setting.
bootconsole [earlyprom0] enabled
ARCH: SUN4U
Ethernet address: 08:00:20:9e:82:fd
Kernel: Using 2 locked TLB entries for main kernel image.
Remapping the kernel... done.
OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
PROM: Built device tree with 49735 bytes of memory.
Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
Memory hole size: 0MB
[0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
[0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
Zone PFN ranges:
Normal 0x00000000 -> 0x0000ff94
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
0: 0x00000000 -> 0x0000ff7f
0: 0x0000ff88 -> 0x0000ff94
On node 0 totalpages: 65419
Normal zone: 512 pages used for memmap
Normal zone: 0 pages reserved
Normal zone: 64907 pages, LIFO batch:15
Booting Linux...
CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
CPU CAPS: [vis]
pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
pcpu-alloc: [0] 0
Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
PID hash table entries: 2048 (order: 1, 16384 bytes)
Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
NR_IRQS:255
clocksource: mult[3555555] shift[24]
clockevent: mult[4ccccccd] shift[32]
Console: colour dummy device 80x25
console [tty0] enabled, bootconsole disabled
Calibrating delay using timer specific routine.. 601.00 BogoMIPS (lpj=3005039)
pid_max: default: 32768 minimum: 301
Mount-cache hash table entries: 512
NET: Registered protocol family 16
/pci@1f,0: PCI IO[1fe02000000] MEM[1ff00000000]
/pci@1f,0: SABRE PCI Bus Module ver[0:0]
PCI: Scanning PBM /pci@1f,0
pci 0000:02:02.0: supports D1 D2
pci 0000:02:02.0: PME# supported from D0 D1 D2 D3hot
pci 0000:02:02.0: PME# disabled
bio: create slab <bio-0> at 0
vgaarb: device added: PCI:0000:01:02.0,decodes=io+mem,owns=none,locks=none
vgaarb: loaded
vgaarb: bridge control possible 0000:01:02.0
SCSI subsystem initialized
/pci@1f,0/pci@1,1/ebus@1/eeprom@14,0: Mostek regs at 0x1fff1000000
AUXIO: Found device at /pci@1f,0/pci@1,1/ebus@1/auxio@14,726000
Switching to clocksource tick
NET: Registered protocol family 2
IP route cache hash table entries: 4096 (order: 2, 32768 bytes)
TCP established hash table entries: 16384 (order: 5, 262144 bytes)
TCP bind hash table entries: 16384 (order: 4, 131072 bytes)
TCP: Hash tables configured (established 16384 bind 16384)
TCP reno registered
UDP hash table entries: 256 (order: 0, 8192 bytes)
UDP-Lite hash table entries: 256 (order: 0, 8192 bytes)
NET: Registered protocol family 1
PCI: CLS 64 bytes, default 64
power: Control reg at 1fff1724000
VFS: Disk quotas dquot_6.5.2
Dquot-cache hash table entries: 1024 (order 0, 8192 bytes)
msgmni has been set to 993
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
io scheduler noop registered
io scheduler deadline registered
io scheduler cfq registered (default)
start plist test
end plist test
PCI: Enabling device: (0000:01:02.0), cmd 82
atyfb: 3D RAGE II+ (Mach64 GT) [0x4754 rev 0x9a]
atyfb: 2M SGRAM (1:1), 14.31818 MHz XTAL, 200 MHz PLL, 67 Mhz MCLK, 67 MHz XCLK
Console: switching to colour frame buffer device 80x30
atyfb: fb0: ATY Mach64 frame buffer device on PCI
/SUNW,ffb@1e,0: FFB at 000001fc00000000, type 51, DAC pnum[236e] rev[10] manuf_rev[1]
/pci@1f,0/pci@1,1/ebus@1/su@14,3083f8: Keyboard port at 1fff13083f8, irq 6
/pci@1f,0/pci@1,1/ebus@1/su@14,3062f8: Mouse port at 1fff13062f8, irq 7
f0061c64: ttyS0 at MMIO 0x1fff1400000 (irq = 5) is a SAB82532 V3.2
Console: ttyS0 (SAB82532)
console [ttyS0] enabled
f0061c64: ttyS1 at MMIO 0x1fff1400040 (irq = 5) is a SAB82532 V3.2
Floppy drive(s): fd0 is 1.44M
FDC 0 is a National Semiconductor PC87306
scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
<Adaptec 2940 Ultra SCSI adapter>
aic7880: Ultra Wide Channel A, SCSI Id=7, 16/253 SCBs
scsi 0:0:0:0: Direct-Access QUANTUM ATLAS IV 18 WLS 0909 PQ: 0 ANSI: 3
scsi0:A:0:0: Tagged Queuing enabled. Depth 253
scsi target0:0:0: Beginning Domain Validation
scsi target0:0:0: wide asynchronous
scsi target0:0:0: FAST-10 WIDE SCSI 20.0 MB/s ST (100 ns, offset 8)
scsi target0:0:0: Domain Validation skipping write tests
scsi target0:0:0: Ending Domain Validation
sd 0:0:0:0: [sda] 35885168 512-byte logical blocks: (18.3 GB/17.1 GiB)
PCI: Enabling device: (0000:01:01.1), cmd 2
sunhme.c:v3.10 August 26, 2008 David S. Miller (davem@davemloft.net)
eth0: HAPPY MEAL (PCI/CheerIO) 10/100BaseT Ethernet 08:00:20:9e:82:fd
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: e3 00 10 08
mousedev: PS/2 mouse device common for all mice
sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
rtc-m48t59 rtc-m48t59.0: rtc core: registered m48t59 as rtc0
TCP cubic registered
NET: Registered protocol family 17
Registering the dns_resolver key type
registered taskstats version 1
rtc-m48t59 rtc-m48t59.0: setting system clock to 2011-11-21 11:41:58 UTC (1321875718)
sda: sda1 sda2 sda3 sda4
sd 0:0:0:0: [sda] Attached SCSI disk
input: Sun Mouse as /devices/root/f005f9c0/f00601b4/f0061504/f0064df4/serio1/input/input0
EXT3-fs (sda4): error: couldn't mount because of unsupported optional features (240)
EXT2-fs (sda4): error: couldn't mount because of unsupported optional features (244)
EXT4-fs (sda4): INFO: recovery required on readonly filesystem
EXT4-fs (sda4): write access will be enabled during recovery
EXT4-fs (sda4): recovery complete
EXT4-fs (sda4): mounted filesystem with ordered data mode. Opts: (null)
VFS: Mounted root (ext4 filesystem) readonly on device 8:4.
8139too: 8139too Fast Ethernet driver 0.9.28
PCI: Enabling device: (0000:02:02.0), cmd 3
8139too 0000:02:02.0: eth1: RealTek RTL8139 at 0x1ff00020000, 00:10:b5:a3:e4:a6, IRQ 16
/pci@1f,0/pci@1,1/ebus@1/flashprom@10,0: OBP Flash, RD 1fff0000000[100000] WR 1fff0000000[100000]
libata version 3.00 loaded.
scsi1 : pata_cmd64x
scsi2 : pata_cmd64x
ata1: PATA max MWDMA2 cmd 0x1fe02c00000 ctl 0x1fe02c00008 bmdma 0x1fe02c00020 irq 14
ata2: PATA max MWDMA2 cmd 0x1fe02c00010 ctl 0x1fe02c00018 bmdma 0x1fe02c00028 irq 14
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
pata_cmd64x: active 10 recovery 10 setup 3.
Adding 1052248k swap on /dev/sda2. Priority:-1 extents:1 across:1052248k
EXT4-fs (sda4): re-mounted. Opts: (null)
eth0: Link is up using internal transceiver at 100Mb/s, Full Duplex.
eth0: no IPv6 routers present
kernel BUG at block/blk-core.c:1000!
\|/ ____ \|/
"@'/ .. \`@"
/_| \__/ |_\
\__U_/
swapper(0): Kernel bad sw trap 5 [#1]
TSTATE: 0000008080e01602 TPC: 00000000005c3380 TNPC: 00000000005c3384 Y: 00000000 Not tainted
TPC: <blk_requeue_request+0x60/0x80>
g0: 0000000000000003 g1: 0000000000872000 g2: 0000000000000001 g3: ffffffffffffffd8
g4: 0000000000869b50 g5: f7ddef20f7767b60 g6: 0000000000860000 g7: 0000000000001000
o0: 0000000000000028 o1: 0000000000816440 o2: 00000000000003e8 o3: 00000000ffffa86e
o4: fffff8001f00cb60 o5: 0000000000816440 sp: fffff8001fefb471 ret_pc: 00000000005c3378
RPC: <blk_requeue_request+0x58/0x80>
l0: 00000000fffc00f0 l1: 0000000000883790 l2: 0000000000000001 l3: fffff8001f0060c0
l4: fffff8001f0020c0 l5: 0000000000000000 l6: 00000000008a2e18 l7: fffffffffffffff8
i0: fffff8001f2d3100 i1: fffff8001f329a20 i2: 000000000091d56c i3: 000000000091d400
i4: 0000000000000001 i5: 0000000000000000 i6: fffff8001fefb521 i7: 000000000065dc10
I7: <__scsi_queue_insert+0xb0/0x100>
Call Trace:
[000000000065dc10] __scsi_queue_insert+0xb0/0x100
[00000000005c812c] blk_done_softirq+0x6c/0xa0
[000000000045a530] __do_softirq+0x90/0x120
[000000000042b054] do_softirq+0x74/0xa0
[000000000045a82c] irq_exit+0x8c/0xa0
[000000000042af9c] handler_irq+0x9c/0xe0
[00000000004208b4] tl0_irq5+0x14/0x20
[0000000000439484] touch_nmi_watchdog+0x4/0x40
[00000000008a8788] start_kernel+0x318/0x328
[000000000074af88] tlb_fixup_done+0x80/0x88
[0000000000000000] (null)
Disabling lock debugging due to kernel taint
Caller[000000000065dc10]: __scsi_queue_insert+0xb0/0x100
Caller[00000000005c812c]: blk_done_softirq+0x6c/0xa0
Caller[000000000045a530]: __do_softirq+0x90/0x120
Caller[000000000042b054]: do_softirq+0x74/0xa0
Caller[000000000045a82c]: irq_exit+0x8c/0xa0
Caller[000000000042af9c]: handler_irq+0x9c/0xe0
Caller[00000000004208b4]: tl0_irq5+0x14/0x20
Caller[000000000042b828]: cpu_idle+0x28/0x60
Caller[00000000008a8788]: start_kernel+0x318/0x328
Caller[000000000074af88]: tlb_fixup_done+0x80/0x88
Caller[0000000000000000]: (null)
Instruction DUMP: 921023e8 7ff99282 90122040 <91d02005> 30680007 01000000 01000000 01000000 01000000
Kernel panic - not syncing: Aiee, killing interrupt handler!
Call Trace:
[00000000004586ec] do_exit+0x2cc/0x300
[00000000004274c0] die_if_kernel+0x180/0x260
[00000000004282d4] bad_trap+0xd4/0xe0
[00000000004220b0] tl0_resv104+0x30/0xa0
[00000000005c3380] blk_requeue_request+0x60/0x80
[000000000065dc10] __scsi_queue_insert+0xb0/0x100
[00000000005c812c] blk_done_softirq+0x6c/0xa0
[000000000045a530] __do_softirq+0x90/0x120
[000000000042b054] do_softirq+0x74/0xa0
[000000000045a82c] irq_exit+0x8c/0xa0
[000000000042af9c] handler_irq+0x9c/0xe0
[00000000004208b4] tl0_irq5+0x14/0x20
[0000000000439484] touch_nmi_watchdog+0x4/0x40
[00000000008a8788] start_kernel+0x318/0x328
[000000000074af88] tlb_fixup_done+0x80/0x88
[0000000000000000] (null)
Press Stop-A (L1-A) to return to the boot prom
--
Meelis Roos (mroos@linux.ee)
^ permalink raw reply [flat|nested] 4+ messages in thread
* Re: 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert)
2011-11-23 10:24 Meelis Roos
@ 2011-12-13 14:04 ` Meelis Roos
2011-12-13 22:04 ` Nadolski, Edmund
0 siblings, 1 reply; 4+ messages in thread
From: Meelis Roos @ 2011-12-13 14:04 UTC (permalink / raw)
To: Linux Kernel list, linux-scsi
Any hope of somebody looking into it? It's still present and
reproducible in 3.2-rc5.
> Hello,
>
> While trying 3.2.0-rc2-00143-ga767835 on Sun Ultra 10 (sparc64) with
> Adaptec SCSI controller, I can consistently get the below BUG shortly
> after bootup. Another machine, Sun Ultra 5 with IDE disk, works fine
> (config might also differ in other details than ide/scsi).
>
> PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
> PROMLIB: Root node compatible:
> Initializing cgroup subsys cpu
> Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
> debug: ignoring loglevel setting.
> bootconsole [earlyprom0] enabled
> ARCH: SUN4U
> Ethernet address: 08:00:20:9e:82:fd
> Kernel: Using 2 locked TLB entries for main kernel image.
> Remapping the kernel... done.
> OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
> PROM: Built device tree with 49735 bytes of memory.
> Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
> Memory hole size: 0MB
> [0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
> [0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
> Zone PFN ranges:
> Normal 0x00000000 -> 0x0000ff94
> Movable zone start PFN for each node
> early_node_map[2] active PFN ranges
> 0: 0x00000000 -> 0x0000ff7f
> 0: 0x0000ff88 -> 0x0000ff94
> On node 0 totalpages: 65419
> Normal zone: 512 pages used for memmap
> Normal zone: 0 pages reserved
> Normal zone: 64907 pages, LIFO batch:15
> Booting Linux...
> CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
> CPU CAPS: [vis]
> pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
> pcpu-alloc: [0] 0
> Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
> Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
> PID hash table entries: 2048 (order: 1, 16384 bytes)
> Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
> Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
> Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
> SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
> NR_IRQS:255
> clocksource: mult[3555555] shift[24]
> clockevent: mult[4ccccccd] shift[32]
> Console: colour dummy device 80x25
> console [tty0] enabled, bootconsole disabled
> PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
> PROMLIB: Root node compatible:
> Initializing cgroup subsys cpu
> Linux version 3.2.0-rc2-00143-ga767835 (mroos@u10) (gcc version 4.6.2 (Debian 4.6.2-4) ) #8 Mon Nov 21 00:18:29 EET 2011
> debug: ignoring loglevel setting.
> bootconsole [earlyprom0] enabled
> ARCH: SUN4U
> Ethernet address: 08:00:20:9e:82:fd
> Kernel: Using 2 locked TLB entries for main kernel image.
> Remapping the kernel... done.
> OF stdout device is: /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
> PROM: Built device tree with 49735 bytes of memory.
> Top of RAM: 0x1ff28000, Total RAM: 0x1ff16000
> Memory hole size: 0MB
> [0000010000000000-fffff80000c00000] page_structs=131072 node=0 entry=0/8192
> [0000010000000000-fffff80001000000] page_structs=131072 node=0 entry=1/8192
> Zone PFN ranges:
> Normal 0x00000000 -> 0x0000ff94
> Movable zone start PFN for each node
> early_node_map[2] active PFN ranges
> 0: 0x00000000 -> 0x0000ff7f
> 0: 0x0000ff88 -> 0x0000ff94
> On node 0 totalpages: 65419
> Normal zone: 512 pages used for memmap
> Normal zone: 0 pages reserved
> Normal zone: 64907 pages, LIFO batch:15
> Booting Linux...
> CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
> CPU CAPS: [vis]
> pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
> pcpu-alloc: [0] 0
> Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64907
> Kernel command line: root=/dev/sda4 ro debug ignore_loglevel
> PID hash table entries: 2048 (order: 1, 16384 bytes)
> Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
> Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
> Memory: 508840k available (3472k kernel code, 1248k data, 168k init) [fffff80000000000,000000001ff28000]
> SLUB: Genslabs=16, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
> NR_IRQS:255
> clocksource: mult[3555555] shift[24]
> clockevent: mult[4ccccccd] shift[32]
> Console: colour dummy device 80x25
> console [tty0] enabled, bootconsole disabled
> Calibrating delay using timer specific routine.. 601.00 BogoMIPS (lpj=3005039)
> pid_max: default: 32768 minimum: 301
> Mount-cache hash table entries: 512
> NET: Registered protocol family 16
> /pci@1f,0: PCI IO[1fe02000000] MEM[1ff00000000]
> /pci@1f,0: SABRE PCI Bus Module ver[0:0]
> PCI: Scanning PBM /pci@1f,0
> pci 0000:02:02.0: supports D1 D2
> pci 0000:02:02.0: PME# supported from D0 D1 D2 D3hot
> pci 0000:02:02.0: PME# disabled
> bio: create slab <bio-0> at 0
> vgaarb: device added: PCI:0000:01:02.0,decodes=io+mem,owns=none,locks=none
> vgaarb: loaded
> vgaarb: bridge control possible 0000:01:02.0
> SCSI subsystem initialized
> /pci@1f,0/pci@1,1/ebus@1/eeprom@14,0: Mostek regs at 0x1fff1000000
> AUXIO: Found device at /pci@1f,0/pci@1,1/ebus@1/auxio@14,726000
> Switching to clocksource tick
> NET: Registered protocol family 2
> IP route cache hash table entries: 4096 (order: 2, 32768 bytes)
> TCP established hash table entries: 16384 (order: 5, 262144 bytes)
> TCP bind hash table entries: 16384 (order: 4, 131072 bytes)
> TCP: Hash tables configured (established 16384 bind 16384)
> TCP reno registered
> UDP hash table entries: 256 (order: 0, 8192 bytes)
> UDP-Lite hash table entries: 256 (order: 0, 8192 bytes)
> NET: Registered protocol family 1
> PCI: CLS 64 bytes, default 64
> power: Control reg at 1fff1724000
> VFS: Disk quotas dquot_6.5.2
> Dquot-cache hash table entries: 1024 (order 0, 8192 bytes)
> msgmni has been set to 993
> Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
> io scheduler noop registered
> io scheduler deadline registered
> io scheduler cfq registered (default)
> start plist test
> end plist test
> PCI: Enabling device: (0000:01:02.0), cmd 82
> atyfb: 3D RAGE II+ (Mach64 GT) [0x4754 rev 0x9a]
> atyfb: 2M SGRAM (1:1), 14.31818 MHz XTAL, 200 MHz PLL, 67 Mhz MCLK, 67 MHz XCLK
> Console: switching to colour frame buffer device 80x30
> atyfb: fb0: ATY Mach64 frame buffer device on PCI
> /SUNW,ffb@1e,0: FFB at 000001fc00000000, type 51, DAC pnum[236e] rev[10] manuf_rev[1]
> /pci@1f,0/pci@1,1/ebus@1/su@14,3083f8: Keyboard port at 1fff13083f8, irq 6
> /pci@1f,0/pci@1,1/ebus@1/su@14,3062f8: Mouse port at 1fff13062f8, irq 7
> f0061c64: ttyS0 at MMIO 0x1fff1400000 (irq = 5) is a SAB82532 V3.2
> Console: ttyS0 (SAB82532)
> console [ttyS0] enabled
> f0061c64: ttyS1 at MMIO 0x1fff1400040 (irq = 5) is a SAB82532 V3.2
> Floppy drive(s): fd0 is 1.44M
> FDC 0 is a National Semiconductor PC87306
> scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
> <Adaptec 2940 Ultra SCSI adapter>
> aic7880: Ultra Wide Channel A, SCSI Id=7, 16/253 SCBs
>
> scsi 0:0:0:0: Direct-Access QUANTUM ATLAS IV 18 WLS 0909 PQ: 0 ANSI: 3
> scsi0:A:0:0: Tagged Queuing enabled. Depth 253
> scsi target0:0:0: Beginning Domain Validation
> scsi target0:0:0: wide asynchronous
> scsi target0:0:0: FAST-10 WIDE SCSI 20.0 MB/s ST (100 ns, offset 8)
> scsi target0:0:0: Domain Validation skipping write tests
> scsi target0:0:0: Ending Domain Validation
> sd 0:0:0:0: [sda] 35885168 512-byte logical blocks: (18.3 GB/17.1 GiB)
> PCI: Enabling device: (0000:01:01.1), cmd 2
> sunhme.c:v3.10 August 26, 2008 David S. Miller (davem@davemloft.net)
> eth0: HAPPY MEAL (PCI/CheerIO) 10/100BaseT Ethernet 08:00:20:9e:82:fd
> sd 0:0:0:0: [sda] Write Protect is off
> sd 0:0:0:0: [sda] Mode Sense: e3 00 10 08
> mousedev: PS/2 mouse device common for all mice
> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
> rtc-m48t59 rtc-m48t59.0: rtc core: registered m48t59 as rtc0
> TCP cubic registered
> NET: Registered protocol family 17
> Registering the dns_resolver key type
> registered taskstats version 1
> rtc-m48t59 rtc-m48t59.0: setting system clock to 2011-11-21 11:41:58 UTC (1321875718)
> sda: sda1 sda2 sda3 sda4
> sd 0:0:0:0: [sda] Attached SCSI disk
> input: Sun Mouse as /devices/root/f005f9c0/f00601b4/f0061504/f0064df4/serio1/input/input0
> EXT3-fs (sda4): error: couldn't mount because of unsupported optional features (240)
> EXT2-fs (sda4): error: couldn't mount because of unsupported optional features (244)
> EXT4-fs (sda4): INFO: recovery required on readonly filesystem
> EXT4-fs (sda4): write access will be enabled during recovery
> EXT4-fs (sda4): recovery complete
> EXT4-fs (sda4): mounted filesystem with ordered data mode. Opts: (null)
> VFS: Mounted root (ext4 filesystem) readonly on device 8:4.
> 8139too: 8139too Fast Ethernet driver 0.9.28
> PCI: Enabling device: (0000:02:02.0), cmd 3
> 8139too 0000:02:02.0: eth1: RealTek RTL8139 at 0x1ff00020000, 00:10:b5:a3:e4:a6, IRQ 16
> /pci@1f,0/pci@1,1/ebus@1/flashprom@10,0: OBP Flash, RD 1fff0000000[100000] WR 1fff0000000[100000]
> libata version 3.00 loaded.
> scsi1 : pata_cmd64x
> scsi2 : pata_cmd64x
> ata1: PATA max MWDMA2 cmd 0x1fe02c00000 ctl 0x1fe02c00008 bmdma 0x1fe02c00020 irq 14
> ata2: PATA max MWDMA2 cmd 0x1fe02c00010 ctl 0x1fe02c00018 bmdma 0x1fe02c00028 irq 14
> pata_cmd64x: active 10 recovery 10 setup 3.
> pata_cmd64x: active 10 recovery 10 setup 3.
> pata_cmd64x: active 10 recovery 10 setup 3.
> pata_cmd64x: active 10 recovery 10 setup 3.
> Adding 1052248k swap on /dev/sda2. Priority:-1 extents:1 across:1052248k
> EXT4-fs (sda4): re-mounted. Opts: (null)
> eth0: Link is up using internal transceiver at 100Mb/s, Full Duplex.
> eth0: no IPv6 routers present
> kernel BUG at block/blk-core.c:1000!
> \|/ ____ \|/
> "@'/ .. \`@"
> /_| \__/ |_\
> \__U_/
> swapper(0): Kernel bad sw trap 5 [#1]
> TSTATE: 0000008080e01602 TPC: 00000000005c3380 TNPC: 00000000005c3384 Y: 00000000 Not tainted
> TPC: <blk_requeue_request+0x60/0x80>
> g0: 0000000000000003 g1: 0000000000872000 g2: 0000000000000001 g3: ffffffffffffffd8
> g4: 0000000000869b50 g5: f7ddef20f7767b60 g6: 0000000000860000 g7: 0000000000001000
> o0: 0000000000000028 o1: 0000000000816440 o2: 00000000000003e8 o3: 00000000ffffa86e
> o4: fffff8001f00cb60 o5: 0000000000816440 sp: fffff8001fefb471 ret_pc: 00000000005c3378
> RPC: <blk_requeue_request+0x58/0x80>
> l0: 00000000fffc00f0 l1: 0000000000883790 l2: 0000000000000001 l3: fffff8001f0060c0
> l4: fffff8001f0020c0 l5: 0000000000000000 l6: 00000000008a2e18 l7: fffffffffffffff8
> i0: fffff8001f2d3100 i1: fffff8001f329a20 i2: 000000000091d56c i3: 000000000091d400
> i4: 0000000000000001 i5: 0000000000000000 i6: fffff8001fefb521 i7: 000000000065dc10
> I7: <__scsi_queue_insert+0xb0/0x100>
> Call Trace:
> [000000000065dc10] __scsi_queue_insert+0xb0/0x100
> [00000000005c812c] blk_done_softirq+0x6c/0xa0
> [000000000045a530] __do_softirq+0x90/0x120
> [000000000042b054] do_softirq+0x74/0xa0
> [000000000045a82c] irq_exit+0x8c/0xa0
> [000000000042af9c] handler_irq+0x9c/0xe0
> [00000000004208b4] tl0_irq5+0x14/0x20
> [0000000000439484] touch_nmi_watchdog+0x4/0x40
> [00000000008a8788] start_kernel+0x318/0x328
> [000000000074af88] tlb_fixup_done+0x80/0x88
> [0000000000000000] (null)
> Disabling lock debugging due to kernel taint
> Caller[000000000065dc10]: __scsi_queue_insert+0xb0/0x100
> Caller[00000000005c812c]: blk_done_softirq+0x6c/0xa0
> Caller[000000000045a530]: __do_softirq+0x90/0x120
> Caller[000000000042b054]: do_softirq+0x74/0xa0
> Caller[000000000045a82c]: irq_exit+0x8c/0xa0
> Caller[000000000042af9c]: handler_irq+0x9c/0xe0
> Caller[00000000004208b4]: tl0_irq5+0x14/0x20
> Caller[000000000042b828]: cpu_idle+0x28/0x60
> Caller[00000000008a8788]: start_kernel+0x318/0x328
> Caller[000000000074af88]: tlb_fixup_done+0x80/0x88
> Caller[0000000000000000]: (null)
> Instruction DUMP: 921023e8 7ff99282 90122040 <91d02005> 30680007 01000000 01000000 01000000 01000000
> Kernel panic - not syncing: Aiee, killing interrupt handler!
> Call Trace:
> [00000000004586ec] do_exit+0x2cc/0x300
> [00000000004274c0] die_if_kernel+0x180/0x260
> [00000000004282d4] bad_trap+0xd4/0xe0
> [00000000004220b0] tl0_resv104+0x30/0xa0
> [00000000005c3380] blk_requeue_request+0x60/0x80
> [000000000065dc10] __scsi_queue_insert+0xb0/0x100
> [00000000005c812c] blk_done_softirq+0x6c/0xa0
> [000000000045a530] __do_softirq+0x90/0x120
> [000000000042b054] do_softirq+0x74/0xa0
> [000000000045a82c] irq_exit+0x8c/0xa0
> [000000000042af9c] handler_irq+0x9c/0xe0
> [00000000004208b4] tl0_irq5+0x14/0x20
> [0000000000439484] touch_nmi_watchdog+0x4/0x40
> [00000000008a8788] start_kernel+0x318/0x328
> [000000000074af88] tlb_fixup_done+0x80/0x88
> [0000000000000000] (null)
> Press Stop-A (L1-A) to return to the boot prom
>
>
--
Meelis Roos (mroos@linux.ee)
^ permalink raw reply [flat|nested] 4+ messages in thread
* RE: 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert)
2011-12-13 14:04 ` Meelis Roos
@ 2011-12-13 22:04 ` Nadolski, Edmund
0 siblings, 0 replies; 4+ messages in thread
From: Nadolski, Edmund @ 2011-12-13 22:04 UTC (permalink / raw)
To: Meelis Roos, Linux Kernel list, linux-scsi@vger.kernel.org
Cc: Williams, Dan J
> -----Original Message-----
> From: linux-scsi-owner@vger.kernel.org [mailto:linux-scsi-owner@vger.kernel.org] On Behalf Of Meelis
> Roos
> Sent: Tuesday, December 13, 2011 7:04 AM
> To: Linux Kernel list; linux-scsi@vger.kernel.org
> Subject: Re: 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert)
>
> Any hope of somebody looking into it? It's still present and
> reproducible in 3.2-rc5.
>
> > Hello,
> >
> > While trying 3.2.0-rc2-00143-ga767835 on Sun Ultra 10 (sparc64) with
> > Adaptec SCSI controller, I can consistently get the below BUG shortly
> > after bootup. Another machine, Sun Ultra 5 with IDE disk, works fine
> > (config might also differ in other details than ide/scsi).
...
> > kernel BUG at block/blk-core.c:1000!
> > \|/ ____ \|/
> > "@'/ .. \`@"
> > /_| \__/ |_\
> > \__U_/
> > swapper(0): Kernel bad sw trap 5 [#1]
> > TSTATE: 0000008080e01602 TPC: 00000000005c3380 TNPC: 00000000005c3384 Y: 00000000 Not tainted
> > TPC: <blk_requeue_request+0x60/0x80>
> > g0: 0000000000000003 g1: 0000000000872000 g2: 0000000000000001 g3: ffffffffffffffd8
> > g4: 0000000000869b50 g5: f7ddef20f7767b60 g6: 0000000000860000 g7: 0000000000001000
> > o0: 0000000000000028 o1: 0000000000816440 o2: 00000000000003e8 o3: 00000000ffffa86e
> > o4: fffff8001f00cb60 o5: 0000000000816440 sp: fffff8001fefb471 ret_pc: 00000000005c3378
> > RPC: <blk_requeue_request+0x58/0x80>
> > l0: 00000000fffc00f0 l1: 0000000000883790 l2: 0000000000000001 l3: fffff8001f0060c0
> > l4: fffff8001f0020c0 l5: 0000000000000000 l6: 00000000008a2e18 l7: fffffffffffffff8
> > i0: fffff8001f2d3100 i1: fffff8001f329a20 i2: 000000000091d56c i3: 000000000091d400
> > i4: 0000000000000001 i5: 0000000000000000 i6: fffff8001fefb521 i7: 000000000065dc10
> > I7: <__scsi_queue_insert+0xb0/0x100>
> > Call Trace:
> > [000000000065dc10] __scsi_queue_insert+0xb0/0x100
> > [00000000005c812c] blk_done_softirq+0x6c/0xa0
> > [000000000045a530] __do_softirq+0x90/0x120
> > [000000000042b054] do_softirq+0x74/0xa0
> > [000000000045a82c] irq_exit+0x8c/0xa0
> > [000000000042af9c] handler_irq+0x9c/0xe0
> > [00000000004208b4] tl0_irq5+0x14/0x20
> > [0000000000439484] touch_nmi_watchdog+0x4/0x40
> > [00000000008a8788] start_kernel+0x318/0x328
> > [000000000074af88] tlb_fixup_done+0x80/0x88
> > [0000000000000000] (null)
I see similar to this using 3.2.0-rc5+ on x86_64 with one SAS drive
on an Intel C600. It hits every time I run mkfs. Stack shown
below. Running 'git bisect' leads to this:
commit b4fdcb02f1e39c27058a885905bd0277370ba441
Merge: 044595d 6dd9ad7
Author: Linus Torvalds <torvalds@linux-foundation.org>
Date: Fri Nov 4 17:06:58 2011 -0700
Merge branch 'for-3.2/core' of git://git.kernel.dk/linux-block
I see the failure with git reset --hard b4fdcb0, but it does not
occur with git reset --hard 6dd9ad7 or git reset --hard 044595d.
Any thoughts on what I can try next?
Thanks,
Ed
[root@scutest0 ~]# mkfs -t ext3 /dev/sdb1
mke2fs 1.41.12 (17-May-2010)
Filesystem label=
OS type: Linux
Block size=4096 (log=2)
Fragment size=4096 (log=2)
Stride=0 blocks, Stripe width=0 blocks
8978432 inodes, 35909283 blocks
1795464 blocks (5.00%) reserved for the super user
First data block=0
Maximum filesystem blocks=4294967296
1096 block groups
32768 blocks per group, 32768 fragments per group
8192 inodes per group
Superblock backups stored on blocks:
32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208,
4096000, 7962624, 11239424, 20480000, 23887872
Writing inode tables: done
Creating journal (32768 blocks): done
Writing superblocks and filesystem accounting information: [ 122.752553] ------------[ cut here ]------------
[ 122.757713] kernel BUG at block/blk-core.c:1000!
[ 122.762863] invalid opcode: 0000 [#1] SMP
[ 122.767465] CPU 8
[ 122.769518] Modules linked in: cpufreq_ondemand acpi_cpufreq freq_table mperf ipv6 uinput iTCO_wdt iTCO_vendor_support i2c_i801 i2c_core ioatdma dca isci libsas scsi_transport_sas [last unloaded: scsi_wait_scan]
[ 122.790910]
[ 122.792578] Pid: 0, comm: swapper/8 Not tainted 3.2.0-rc5+ #2 Intel Corporation S2600CP/S2600CP
[ 122.802322] RIP: 0010:[<ffffffff81267e81>] [<ffffffff81267e81>] blk_requeue_request+0x6b/0x82
[ 122.811962] RSP: 0018:ffff88083fa03dd0 EFLAGS: 00010006
[ 122.817885] RAX: 0000000000000000 RBX: ffff880766890b00 RCX: ffff88083fa03dc0
[ 122.825844] RDX: ffff8808205c2bd0 RSI: ffff880766890b00 RDI: ffff880422f694c0
[ 122.833810] RBP: ffff88083fa03df0 R08: ffff880766890c30 R09: 0000000000000001
[ 122.841769] R10: 0000000000000000 R11: ffff880422f69b20 R12: ffff880823217000
[ 122.849735] R13: ffff880422f694c0 R14: ffff880422f694c0 R15: ffff880423a5f000
[ 122.857695] FS: 0000000000000000(0000) GS:ffff88083fa00000(0000) knlGS:0000000000000000
[ 122.866719] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 122.873128] CR2: 00000000008a9000 CR3: 000000081818c000 CR4: 00000000000406e0
[ 122.881101] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 122.889061] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 122.897021] Process swapper/8 (pid: 0, threadinfo ffff880425fbc000, task ffff880425fb5f40)
[ 122.906247] Stack:
[ 122.908489] ffffffff813547e0 0000000000000282 ffff880823217000 ffff880423a5e000
[ 122.916792] ffff88083fa03e40 ffffffff813547f3 ffff88083fa03e30 ffff880423432028
[ 122.925087] ffff880766978d80 ffff880823217000 0000000000002006 0000000000007530
[ 122.933383] Call Trace:
[ 122.936122] <IRQ>
[ 122.938484] [<ffffffff813547e0>] ? __scsi_queue_insert+0xc9/0x10b
[ 122.945386] [<ffffffff813547f3>] __scsi_queue_insert+0xdc/0x10b
[ 122.952086] [<ffffffff81354cce>] scsi_queue_insert+0x13/0x15
[ 122.958495] [<ffffffff81354db7>] scsi_softirq_done+0xe7/0x108
[ 122.965018] [<ffffffff8126d5b4>] blk_done_softirq+0x84/0x98
[ 122.971340] [<ffffffff810566c5>] __do_softirq+0xe3/0x1d5
[ 122.977392] [<ffffffff81511c67>] ? _raw_spin_lock+0x39/0x40
[ 122.983713] [<ffffffff810b36e2>] ? handle_irq_event+0x4f/0x65
[ 122.990230] [<ffffffff8151b3fc>] call_softirq+0x1c/0x30
[ 122.996167] [<ffffffff81010b5f>] do_softirq+0x4b/0xa3
[ 123.001888] [<ffffffff810563e5>] irq_exit+0x53/0xca
[ 123.007433] [<ffffffff8151bd0d>] do_IRQ+0x9d/0xb4
[ 123.012790] [<ffffffff815125b3>] common_interrupt+0x73/0x73
[ 123.019101] <EOI>
[ 123.021467] [<ffffffff8107bc7f>] ? tick_nohz_stop_sched_tick+0x31c/0x361
[ 123.029057] [<ffffffff810169d7>] ? mwait_idle+0xa1/0xde
[ 123.034981] [<ffffffff810169ce>] ? mwait_idle+0x98/0xde
[ 123.040905] [<ffffffff8100ee58>] cpu_idle+0xca/0x108
[ 123.046550] [<ffffffff81509796>] start_secondary+0x255/0x257
[ 123.052960] Code: 48 89 da 4c 89 ee 41 ff 14 24 49 83 c4 10 49 83 3c 24 00 eb e4 f6 43 42 08 74 0b 48 89 de 4c 89 ef e8 35 20 00 00 48 39 1b 74 04 <0f> 0b eb fe 48 89 de 4c 89 ef e8 1b bb ff ff 5e 5b 41 5c 41 5d
[ 123.074691] RIP [<ffffffff81267e81>] blk_requeue_request+0x6b/0x82
[ 123.081700] RSP <ffff88083fa03dd0>
[ 123.085598] ---[ end trace ebaf24a04fa3b80a ]---
[ 123.090747] Kernel panic - not syncing: Fatal exception in interrupt
[ 123.097833] Pid: 0, comm: swapper/8 Tainted: G D 3.2.0-rc5+ #2
[ 123.105309] Call Trace:
[ 123.108034] <IRQ> [<ffffffff8150f58b>] panic+0x91/0x1b2
[ 123.114079] [<ffffffff81513332>] oops_end+0xb7/0xc7
[ 123.119616] [<ffffffff81011b5e>] die+0x5a/0x63
[ 123.124670] [<ffffffff81512ff0>] do_trap+0x121/0x130
[ 123.130305] [<ffffffff8100ffcb>] do_invalid_op+0x94/0x9d
[ 123.136327] [<ffffffff81267e81>] ? blk_requeue_request+0x6b/0x82
[ 123.143141] [<ffffffff81284a3d>] ? trace_hardirqs_off_thunk+0x3a/0x3c
[ 123.150423] [<ffffffff815126a4>] ? restore_args+0x30/0x30
[ 123.156555] [<ffffffff8151b17b>] invalid_op+0x1b/0x20
[ 123.162286] [<ffffffff81267e81>] ? blk_requeue_request+0x6b/0x82
[ 123.169084] [<ffffffff813547e0>] ? __scsi_queue_insert+0xc9/0x10b
[ 123.175979] [<ffffffff813547f3>] __scsi_queue_insert+0xdc/0x10b
[ 123.182681] [<ffffffff81354cce>] scsi_queue_insert+0x13/0x15
[ 123.189092] [<ffffffff81354db7>] scsi_softirq_done+0xe7/0x108
[ 123.195598] [<ffffffff8126d5b4>] blk_done_softirq+0x84/0x98
[ 123.201911] [<ffffffff810566c5>] __do_softirq+0xe3/0x1d5
[ 123.207932] [<ffffffff81511c67>] ? _raw_spin_lock+0x39/0x40
[ 123.214244] [<ffffffff810b36e2>] ? handle_irq_event+0x4f/0x65
[ 123.220758] [<ffffffff8151b3fc>] call_softirq+0x1c/0x30
[ 123.226691] [<ffffffff81010b5f>] do_softirq+0x4b/0xa3
[ 123.232422] [<ffffffff810563e5>] irq_exit+0x53/0xca
[ 123.237958] [<ffffffff8151bd0d>] do_IRQ+0x9d/0xb4
[ 123.243303] [<ffffffff815125b3>] common_interrupt+0x73/0x73
[ 123.249621] <EOI> [<ffffffff8107bc7f>] ? tick_nohz_stop_sched_tick+0x31c/0x361
[ 123.257883] [<ffffffff810169d7>] ? mwait_idle+0xa1/0xde
[ 123.263808] [<ffffffff810169ce>] ? mwait_idle+0x98/0xde
[ 123.269741] [<ffffffff8100ee58>] cpu_idle+0xca/0x108
[ 123.275376] [<ffffffff81509796>] start_secondary+0x255/0x257
^ permalink raw reply [flat|nested] 4+ messages in thread
end of thread, other threads:[~2011-12-13 22:05 UTC | newest]
Thread overview: 4+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2011-11-23 10:20 3.2-rc2+git: kernel BUG at block/blk-core.c:1000! (__scsi_queue_insert) Meelis Roos
-- strict thread matches above, loose matches on Subject: below --
2011-11-23 10:24 Meelis Roos
2011-12-13 14:04 ` Meelis Roos
2011-12-13 22:04 ` Nadolski, Edmund
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox