Re: 2.6.30-git(16 and 17) system hangs after resume from suspend to disk, mce related?

[Maciej Rutecki]

2009/6/22 Andi Kleen <ak@xxxxxxxxxxxxxxx>:

> Was this with check_interval = 1 ?
>
> Do you see something when you set it to 60 or so (you need to wait 60
> seconds)?

I try check_interval=10 before suspend fot machinecheck0 and
mechinecheck1. Suspend to disk works (not hangs like for "1"). System
hangs few seconds after resume:
[...]
[   68.071137] CPU1 is up
[   68.073336] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level,
low) -> IRQ 16
[   68.126110] usb usb3: root hub lost power or was reset
[   68.126249] ehci_hcd 0000:00:1d.7: PME# disabled
[   68.132082] r8169 0000:02:00.0: PME# disabled
[   68.132935] serial 00:07: activated
[   68.136433] r8169: eth0: link up
[   68.287417] ata2.01: ACPI cmd ef/03:0c:00:00:00:b0 filtered out
[   68.290331] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out
[   68.302257] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out
[   68.324357] ata1.00: configured for UDMA/133
[   69.656127] btusb 4-1:1.0: no reset_resume for driver btusb?
[   70.708015] usb 5-2: reset low speed USB device using uhci_hcd and address 3

It seems, that resume isn't resume completely.


Also I try 20 seconds and find this in netconsole:
[  532.576128] BUG: soft lockup - CPU#1 stuck for 61s! [ksensors:2670]
[  532.576128] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit snd[
532.576128]  DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[  532.576128]  [<c01a266d>] sys_read+0x3d/0x70
^[[B^[[A[  598.075129] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq_device[  598.075129] EAX: 00000001 EBX: c28023e0 ECX: 00000292
EDX: 000008fb
[  598.075129]  [<c01a24f9>] vfs_read+0x99/0x150
[  663.573129] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_timer[  663.573129] EIP is at generic_exec_single+0x5e/0x90
[  663.573129]  [<c01a24f9>] vfs_read+0x99/0x150
[  729.071129] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq[  729.071129] EIP: 0060:[<c015979a>] EFLAGS: 00000202 CPU: 1
[  729.071129]  [<c0226aaf>] ? security_file_permission+0xf/0x20
[  794.569130] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
iptable_filter nf_defrag_ipv4 fuse coretemp loop bluetooth
snd_hda_codec[  860.068130] BUG: softlockup - CPU#1 stuck for 61s!
[ksensors:2670]
[  860.068130] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
nf_conntrack x_tables dm_mod hwmon_vid btusb snd_hda_intel[
925.566131] Modules linked in: i915drm i2c_algo_bit video backlight
output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
iptable_filter nf_conntrack x_tables dm_mod loop btusb snd_hda_intel[
991.064131] Modules linked in: i915 drm i2c_algo_bit video backlight
output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state snd_seq[
991.064131] EIP: 0060:[<c0159798>] EFLAGS: 00000202 CPU: 1
[  991.064131]  [<c0226aaf>] ? security_file_permission+0xf/0x20
[ 1056.562131] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq_midi_event[ 1056.562131] EIP: 0060:[<c015979a>] EFLAGS:
00000202 CPU: 1
[ 1056.562131]  [<c01ec20d>] sysfs_read_file+0x7d/0x110
[ 1122.061132] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq_device[ 1122.061132] EAX: 00000001 EBX: c28023e0 ECX: 00000292
EDX: 000008fb
[ 1122.061132]  [<c01a24f9>] vfs_read+0x99/0x150
[ 1187.559132] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq_device[ 1187.559132] EAX: 00000001 EBX: c28023e0 ECX: 00000292
EDX: 000008fb
[ 1187.559132]  [<c01a24f9>] vfs_read+0x99/0x150
[ 1253.057133] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_timer[ 1253.057133] EIP is at generic_exec_single+0x5e/0x90
[ 1253.057133]  [<c01a24f9>] vfs_read+0x99/0x150
[ 1318.555133] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq[ 1318.555133] EIP is at generic_exec_single+0x5a/0x90
[ 1318.555133]  [<c0226aaf>] ? security_file_permission+0xf/0x20
[ 1384.054133] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd[ 1384.054133] EAX: 00000001 EBX: c28023e0 ECX: 00000292 EDX:
000008fb
[ 1384.054133]  [<c01ec190>] ? sysfs_read_file+0x0/0x110
[ 1449.552134] Modules linked in: i915 drm i2c_algo_bit video
backlight output ppdev lp rfcomm l2cap xt_tcpudp xt_limit xt_state
snd_seq_device[ 1449.552134] EAX: 00000001 EBX: c28023e0 ECX: 00000292
EDX: 000008fb
[ 1449.552134]  [<c01a24f9>] vfs_read+0x99/0x150

Message appears very slowly.


-- 
Maciej Rutecki
http://www.maciek.unixy.pl
--
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/