Mailing List Archive

[Fwd: soft lockup in 2.6.26-rc1+git, on Fire V100]
For your information if you don't subscribe to sparclinux@

-------- Forwarded Message --------
From: Meelis Roos <mroos@linux.ee>
To: sparclinux@vger.kernel.org
Subject: soft lockup in 2.6.26-rc1+git, on Fire V100
Date: Mon, 5 May 2008 19:13:34 +0300 (EEST)

Tried todays 2.6.26-rc1+git on a Fire V100. It mounted root etc as usual
but hung during "Waiting for /dev to be fully populated...":

Linux Tulip driver version 1.1.15-NAPI (Feb 27, 2007)
tulip0: Old style EEPROM with no media selection information.
tulip0: MII transceiver #1 config 1000 status 782d advertising 01e1.
eth0: Davicom DM9102/DM9102A rev 49 at MMIO 0x1ff00000000, EEPROM not present, 00:03:ba:11:b3:71, IRQ 9.
tulip1: Old style EEPROM with no media selection information.
tulip1: MII transceiver #1 config 1000 status 7809 advertising 01e1.
eth1: Davicom DM9102/DM9102A rev 49 at MMIO 0x1ff00002000, EEPROM not present, 00:03:ba:11:b3:72, IRQ 10.
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
ohci_hcd 0000:00:0a.0: OHCI Host Controller
ohci_hcd 0000:00:0a.0: new USB bus registered, assigned bus number 1
ohci_hcd 0000:00:0a.0: irq 11, io mem 0x1ff01000000
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
Driver 'sr' needs updating - please use bus_type methods
usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb1: Product: OHCI Host Controller
usb usb1: Manufacturer: Linux 2.6.26-rc1-00050-gf74d505-dirty ohci_hcd
usb usb1: SerialNumber: 0000:00:0a.0

[.
Now was a pause and the the following soft lockup message appeard.
Sysrq-T is caoused by me, trying to understand what modprobe has caused
this but there are several of them running.
]

BUG: soft lockup - CPU#0 stuck for 61s! [modprobe:414]
TSTATE: 0000001980009603 TPC: 00000000005e3c48 TNPC: 00000000005e3c4c Y: 00000000 Not tainted
TPC: <neigh_periodic_timer+0xd0/0x160>
g0: 0000000000009000 g1: 0000000000000002 g2: 00000000000005dc g3: 0000000000000001
g4: fffff8006e4d0ac0 g5: 73725f6d6f640010 g6: fffff8006e144000 g7: 0000000000000000
o0: 0000000000000002 o1: fffff8006e144400 o2: 00000000005e3b84 o3: 0000000000000000
o4: fffff8006e1b4e10 o5: 0000000000000001 sp: fffff8006e1466b1 ret_pc: 0000000000404980
RPC: <__handle_softirq+0x8/0x10>
l0: 00000000ffffa657 l1: 0000000000000001 l2: 00000000005e3b80 l3: 0000000000000400
l4: 0000000000000000 l5: 0000000000000003 l6: 0000000000000000 l7: 0000000000000008
i0: 000000000071d660 i1: fffff8006e003290 i2: 0000000000000001 i3: 7fffffffffffffff
i4: 0000000000700730 i5: 0000000000700780 i6: fffff8006e146771 i7: 000000000045d9e0
I7: <run_timer_softirq+0x188/0x200>

SysRq : Show State
task PC stack pid father
init R running task 0 1 0
Call Trace:
[000000000065bd18] schedule_timeout+0x60/0xc0
[00000000004bab3c] do_select+0x3a4/0x440
[00000000004e0cb8] compat_core_sys_select+0x140/0x200
[00000000004e122c] compat_sys_select+0xf4/0x1c0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000014c00] 0x14c08
kthreadd S 0000000000426d90 0 2 0
Call Trace:
[0000000000468894] kthreadd+0x11c/0x180
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000655d04] rest_init+0x2c/0x60
ksoftirqd/0 R running task 0 3 2
Call Trace:
[0000000000459288] ksoftirqd+0xb0/0x100
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
watchdog/0 R running task 0 4 2
Call Trace:
[000000000047d4fc] watchdog+0xa4/0x200
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
events/0 R running task 0 5 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
khelper S 000000000046893c 0 6 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
kblockd/0 R running task 0 90 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
cqueue S 000000000046893c 0 92 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
ata/0 S 000000000046893c 0 96 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
ata_aux S 000000000046893c 0 97 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
pdflush S 000000000046893c 0 120 2
Call Trace:
[000000000048bfe4] pdflush+0xcc/0x1c0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
pdflush R running task 0 121 2
Call Trace:
[000000000048bfe4] pdflush+0xcc/0x1c0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
kswapd0 S 000000000046893c 0 122 2
Call Trace:
[000000000048ffa8] kswapd+0x4b0/0x4c0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
aio/0 S 000000000046893c 0 181 2
Call Trace:
[0000000000464c20] worker_thread+0xa8/0xc0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
scsi_eh_0 S 000000000046893c 0 286 2
Call Trace:
[00000000005a2c84] scsi_error_handler+0x8c/0x3e0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
scsi_eh_1 R running task 0 289 2
Call Trace:
[00000000005a2c84] scsi_error_handler+0x8c/0x3e0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
kjournald S 000000000046893c 0 313 2
Call Trace:
[000000000052869c] kjournald+0x164/0x1a0
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
init S 0000000000457198 0 318 1
Call Trace:
[0000000000456e08] do_wait+0x8f0/0xc00
[0000000000457198] sys_wait4+0x80/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[00000000000155bc] 0x155c4
rc S 0000000000457198 0 319 318
Call Trace:
[0000000000456e08] do_wait+0x8f0/0xc00
[0000000000457198] sys_wait4+0x80/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000046808] 0x46810
S03udev S 0000000000457198 0 351 319
Call Trace:
[0000000000456e08] do_wait+0x8f0/0xc00
[0000000000457198] sys_wait4+0x80/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000046808] 0x46810
udevd R running task 0 382 1
Call Trace:
[0000000000404990] __handle_preemption+0x8/0x10
[000000000000017e] 0x186
udevsettle R running task 0 398 351
Call Trace:
[000000000065cc04] do_nanosleep+0x8c/0xc0
[000000000046c2dc] hrtimer_nanosleep+0x64/0xe0
[000000000047cd2c] compat_sys_nanosleep+0x94/0x100
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[00000000f7ed83f8] 0xf7ed8400
udevd S 0000000000457198 0 413 382
Call Trace:
[0000000000456e08] do_wait+0x8f0/0xc00
[0000000000457198] sys_wait4+0x80/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000017fdc] 0x17fe4
modprobe R running task 0 414 413
Call Trace:
[000000000058bda8] __handle_sysrq+0xd0/0x1a0
[0000000000592500] sunsu_serial_interrupt+0x4e8/0x6c0
[000000000047dd4c] handle_IRQ_event+0x34/0xa0
[000000000047f2dc] handle_fasteoi_irq+0x64/0xe0
[000000000042d548] handler_irq+0x70/0xa0
[00000000004208b4] tl0_irq5+0x1c/0x20
[0000000000404980] __handle_softirq+0x8/0x10
[000000000045d9e0] run_timer_softirq+0x188/0x200
[00000000004590e4] __do_softirq+0x6c/0xe0
[00000000004591b8] do_softirq+0x60/0x80
[0000000000459344] irq_exit+0x6c/0xa0
[000000000042d558] handler_irq+0x80/0xa0
[00000000004208b4] tl0_irq5+0x1c/0x20
[fffff8006e147619] 0xfffff8006e147621
[000000001001d638] usb_hcd_poll_rh_status+0x40/0x180 [usbcore]
[000000001001dafc] usb_add_hcd+0x384/0x5c0 [usbcore]
khubd R running task 0 451 2
Call Trace:
[000000001001c558] hub_thread+0xf20/0xfe0 [usbcore]
[000000000046893c] kthread+0x44/0x80
[0000000000426d90] kernel_thread+0x38/0x60
[0000000000468840] kthreadd+0xc8/0x180
udevd S 00000000004bab3c 0 457 382
Call Trace:
[000000000065bd3c] schedule_timeout+0x84/0xc0
[00000000004bab3c] do_select+0x3a4/0x440
[00000000004e0cb8] compat_core_sys_select+0x140/0x200
[00000000004e1164] compat_sys_select+0x2c/0x1c0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000017cec] 0x17cf4
udevd S 0000000000457198 0 464 382
Call Trace:
[0000000000456e08] do_wait+0x8f0/0xc00
[0000000000457198] sys_wait4+0x80/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000017fdc] 0x17fe4
modprobe D 000000000065b408 0 465 464
Call Trace:
[000000000065bd3c] schedule_timeout+0x84/0xc0
[000000000065b408] wait_for_common+0x90/0x160
[0000000000543230] blk_execute_rq+0x58/0xa0
[00000000005a5974] scsi_execute+0xbc/0xe0
[00000000005a59f4] scsi_execute_req+0x5c/0xc0
[000000001005c28c] sr_test_unit_ready+0x54/0x120 [sr_mod]
[000000001005ca78] sr_probe+0x1a0/0x5e0 [sr_mod]
[000000000059780c] driver_probe_device+0x94/0x1a0
[0000000000597974] __driver_attach+0x5c/0x80
[000000000059704c] bus_for_each_dev+0x54/0x80
[0000000000596860] bus_add_driver+0xa8/0x260
[0000000000597b78] driver_register+0x60/0x160
[0000000010064028] init_sr+0x30/0x4c [sr_mod]
[0000000000478acc] sys_init_module+0x114/0x1800
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[0000000000013f70] 0x13f78
vol_id D 0000000000483a64 0 485 457
Call Trace:
[000000000065bb1c] io_schedule+0x44/0xa0
[0000000000483a64] sync_page+0x4c/0x80
[0000000000483aa4] sync_page_killable+0xc/0x60
[000000000065bf78] __wait_on_bit_lock+0x60/0xa0
[0000000000483980] __lock_page_killable+0x48/0x60
[0000000000485dc0] generic_file_aio_read+0x328/0x5a0
[00000000004ac190] do_sync_read+0x98/0xe0
[00000000004acc68] vfs_read+0x70/0x140
[00000000004acdec] sys_read+0x34/0x60
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[00000000f7ec7f48] 0xf7ec7f50
udevd ? 0000000000457a64 0 498 382
Call Trace:
[00000000004577d4] do_exit+0x51c/0x780
[0000000000457a64] do_group_exit+0x2c/0xc0
[00000000004060d4] linux_sparc_syscall32+0x3c/0x40
[00000000f7e59550] 0xf7e59558

--
Ferris McCormick (P44646, MI) <fmccor@gentoo.org>
Developer, Gentoo Linux (Devrel, Sparc, Userrel, Trustees)