Re: 2.6.24-rc5-mm1 - SCSI/blkdev probing hang

[Rik van Riel]

On Thu, 13 Dec 2007 02:40:50 -0800
Andrew Morton <akpm@xxxxxxxxxxxxxxxxxxxx> wrote:

> 

2.6.24-rc5-mm1 seems to have a hang related to the SCSI or block
device probing code.

This is on a dual quad-core x86-64 system with megaraid_sas controller.

scsi 0:2:0:0: Direct-Access     DELL     PERC 5/i         1.03 PQ: 0 ANSI: 5
general protection fault: 0000 [1] SMP 
last sysfs file: /sys/class/firmware/timeout
CPU 7 
Modules linked in: ata_piix libata dm_snapshot dm_zero dm_mirror dm_mod shpchp megaraid_sas sd_mod scsi_mod ext3 jbd mbcache uhci_hcd ohci_hcd ehci_hcd
Pid: 678, comm: scsi_scan_0 Not tainted 2.6.24-rc5-mm1 #1
RIP: 0010:[<ffffffff81058183>]  [<ffffffff81058183>] mark_lock+0x1b/0x472
RSP: 0018:ffff81043ba29c20  EFLAGS: 00010002
RAX: 0000000000000010 RBX: ffff81043b9ee8f0 RCX: ffff81043b9ee804
RDX: 6b6b6b6b6b6b6b6b RSI: ffff81043b9ee8f0 RDI: ffff81043b9ee000
RBP: ffff81043b9ee000 R08: 0000000000000002 R09: 0000000000000000
R10: ffffffff81129055 R11: 0000000281128c8d R12: 0000000000000004
R13: 0000000000000001 R14: 0000000000000002 R15: ffff81043e508028
FS:  0000000000000000(0000) GS:ffff81043e4e6a28(0000) knlGS:0000000000000000
CS:  0010 DS: 0018 ES: 0018 CR0: 000000008005003b
CR2: 000000361969afa0 CR3: 0000000000201000 CR4: 00000000000006e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Process scsi_scan_0 (pid: 678, threadinfo ffff81043ba28000, task ffff81043b9ee000)
Stack:  ffff81043b9ee8f0 6b6b6b6b6b6b6b6b ffff81043b9ee000<6>ata1.00: ATAPI: HL-DT-STCD-RW/DVD-ROM GCC-T10N, A102, max UDMA/33
 ffffffff81059139
 000000003ba29c50 0000000000000002 0000000000000000 ffffffff81058623
 ffff81043b504660 0000000000000246 ffff81043e508028 ffff81043b504660
Call Trace:
 [<ffffffff81059139>] __lock_acquire+0x4d7/0xc8e
 [<ffffffff81058623>] mark_held_locks+0x49/0x67
 [<ffffffff81059ce2>] lock_acquire+0x5a/0x73
 [<ffffffff81129055>] kobject_add+0xca/0x194
 [<ffffffff8126d56c>] mutex_lock_nested+0x2a1/0x2b0
 [<ffffffff8126e997>] _spin_lock+0x26/0x52
 [<ffffffff81129055>] kobject_add+0xca/0x194
 [<ffffffff811a318c>] device_add+0x9a/0x56e
 [<ffffffff8805c327>] :scsi_mod:scsi_alloc_target+0x2cd/0x343
 [<ffffffff8805c492>] :scsi_mod:__scsi_scan_target+0x66/0x5c6
 [<ffffffff810587f0>] trace_hardirqs_on+0x115/0x138
 [<ffffffff8805ca37>] :scsi_mod:scsi_scan_channel+0x45/0x70
 [<ffffffff8805cb37>] :scsi_mod:scsi_scan_host_selected+0xd5/0x110
ata1.00: configured for UDMA/33
ata2: port disabled. ignoring.
 [<ffffffff8805cbe5>] :scsi_mod:do_scan_async+0x0/0x152
 [<ffffffff8805cbf9>] :scsi_mod:do_scan_async+0x14/0x152
 [<ffffffff8805cbe5>] :scsi_mod:do_scan_async+0x0/0x152
 [<ffffffff8104d4e8>] kthread+0x47/0x73
 [<ffffffff8126e418>] trace_hardirqs_on_thunk+0x35/0x3a
 [<ffffffff8100cee8>] child_rip+0xa/0x12
 [<ffffffff8100c5ff>] restore_args+0x0/0x30
 [<ffffffff811e0908>] menu_reflect+0x0/0x75
 [<ffffffff8104d371>] kthreadd+0x115/0x13a
 [<ffffffff8104d4a1>] kthread+0x0/0x73
 [<ffffffff8100cede>] child_rip+0x0/0x12


Code: 48 85 42 30 0f 85 2e 04 00 00 f0 ff 0d 2c ce 34 00 79 0d f3 
RIP  [<ffffffff81058183>] mark_lock+0x1b/0x472
 RSP <ffff81043ba29c20>
general protection fault: 0000 [2] SMP 
last sysfs file: /sys/class/firmware/timeout
CPU 3 
Modules linked in: ata_piix libata dm_snapshot dm_zero dm_mirror dm_mod shpchp megaraid_sas sd_mod scsi_mod ext3 jbd mbcache uhci_hcd ohci_hcd ehci_hcd
Pid: 743, comm: insmod Tainted: G      D 2.6.24-rc5-mm1 #1
RIP: 0010:[<ffffffff81130cca>]  [<ffffffff81130cca>] __list_add+0x2b/0x5b
RSP: 0000:ffff81043b4319c8  EFLAGS: 00010246
RAX: 6b6b6b6b6b6b6b6b RBX: ffff81043bec4a68 RCX: 0000000000000000
RDX: 6b6b6b6b6b6b6b6b RSI: ffff81043e508000 RDI: ffff81043bec4a78
RBP: ffff81043ba794b0 R08: 0000000000000002 R09: 0000000000000000
R10: ffffffff81129055 R11: ffffffff8102093a R12: ffff81043bec4aa8
R13: 00000000fffffffe R14: 0000000000000000 R15: ffff81043ba79090
FS:  00007fc3239ae6f0(0000) GS:ffff81043fc01d48(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
CR2: 00000036196d5140 CR3: 000000043bb4c000 CR4: 00000000000006e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Process insmod (pid: 743, threadinfo ffff81043b430000, task ffff81043b42e000)
Stack:  ffff81043ba79090 ffffffff81129066 ffff81043ba79098 ffff81043bec48b8
 ffff81043bec4aa8 ffff81043bec48b8 0000000000000000 ffffffff811a318c
 ffff81043ba79098 ffff81043ba79300 ffff81043bec4a68 ffff81043ba79098
Call Trace:
 [<ffffffff81129066>] kobject_add+0xdb/0x194
 [<ffffffff811a318c>] device_add+0x9a/0x56e
 [<ffffffff8805c327>] :scsi_mod:scsi_alloc_target+0x2cd/0x343
 [<ffffffff8805cd92>] :scsi_mod:__scsi_add_device+0x5b/0xd9
 [<ffffffff880c78d4>] :libata:ata_scsi_scan_host+0xa8/0x28b
 [<ffffffff880c4698>] :libata:ata_host_register+0x256/0x280
 [<ffffffff880c9bfd>] :libata:ata_pci_init_one+0x231/0x285
 [<ffffffff880e38cc>] :ata_piix:piix_init_one+0x512/0x53d
 [<ffffffff81012f31>] native_sched_clock+0x47/0x70
 [<ffffffff8126e8ae>] _spin_unlock+0x17/0x20
 [<ffffffff8113a0f7>] pci_device_probe+0xb3/0xfd
 [<ffffffff811a5412>] driver_probe_device+0xee/0x16b
 [<ffffffff811a55d7>] __driver_attach+0x90/0xcc
 [<ffffffff811a5547>] __driver_attach+0x0/0xcc
 [<ffffffff811a5547>] __driver_attach+0x0/0xcc
 [<ffffffff811a4733>] bus_for_each_dev+0x47/0x72
 [<ffffffff811a4ff9>] bus_add_driver+0xc4/0x20b
 [<ffffffff811a5845>] driver_register+0x59/0xcd
 [<ffffffff8113a36c>] __pci_register_driver+0x57/0x8b
 [<ffffffff880eb01e>] :ata_piix:piix_init+0x1e/0x32
 [<ffffffff81061b2a>] sys_init_module+0x15e5/0x173b
 [<ffffffff8100bfae>] system_call+0x7e/0x83
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/