All of lore.kernel.org
 help / color / mirror / Atom feed
* xserver-xorg-video-intel does sometimes not resume
@ 2011-09-20 10:41 Rainer Dorsch
  2011-09-20 16:49 ` Keith Packard
  0 siblings, 1 reply; 2+ messages in thread
From: Rainer Dorsch @ 2011-09-20 10:41 UTC (permalink / raw)
  To: intel-gfx

Hello,

I have occasionally (maybe once a week) the problem, that the video signal on 
my system is dead when resuming after a suspend. The system itself is up an 
running (and re-suspends after 10 minutes of inactivity as configured). When I 
resume the re-suspend, that usually works. I.e. here the 
complete sequence:

1. System suspends
2. Resume, but occasionally no video signal available
3. System re-suspends automatically after 10 minutes of inactivity
4. Resume usually works (or sampling rate too small to hit the problem)

I am using an ASUS P5E-VM HDMI board with an Intel G35 chipset and onboard 
graphics: 

00:02.0 VGA compatible controller: Intel Corporation 82G35 Express Integrated 
Graphics Controller (rev 03) (prog-if 00 [VGA controller])
        Subsystem: ASUSTeK Computer Inc. Device 8276
        Flags: bus master, fast devsel, latency 0, IRQ 44
        Memory at fe800000 (32-bit, non-prefetchable) [size=1M]
        Memory at d0000000 (64-bit, prefetchable) [size=256M]
        I/O ports at cc00 [size=8]
        Expansion ROM at <unassigned> [disabled]
        Capabilities: [90] MSI: Enable+ Count=1/1 Maskable- 64bit-
        Capabilities: [d0] Power Management version 2
        Kernel driver in use: i915

I am using Debian Testing, i.e. 

[    13.816] (II) Module intel: vendor="X.Org Foundation"
[    13.816]    compiled for 1.10.1, module version = 2.15.0
[    13.816]    Module class: X.Org Video Driver
[    13.816]    ABI class: X.Org Video Driver, version 10.0

rd@blackbox:~$ apt-cache policy xserver-xorg-video-intel
xserver-xorg-video-intel:
  Installiert: 2:2.15.0-3
  Kandidat:    2:2.15.0-3
  Versionstabelle:
     2:2.16.0-1 0
        300 http://ftp-stud.fht-esslingen.de/debian/ sid/main i386 Packages
 *** 2:2.15.0-3 0
        600 http://ftp-stud.fht-esslingen.de/debian/ wheezy/main i386 Packages
        100 /var/lib/dpkg/status
rd@blackbox:~$ 

I do not believe that the problem is very specific to this version, but 
happened also with previous modules.

I am wondering what I could do to figure out the root cause of the problem. I 
forgot to try, but I assume, that I could ssh into the machine and do some 
diagnosis, when the problem occurs. Are there logs which could help? I attach 
the syslog below...

Here I attach some lines from syslog:

11:55 - First resume, no video signal (Step 2)
12:07 - Second resume, video signal there (Step 4)

Sep 20 11:21:06 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 11:28:06 blackbox NetworkManager[1510]: <info> sleep requested 
(sleeping: no  enabled: yes)
Sep 20 11:28:06 blackbox NetworkManager[1510]: <info> sleeping or disabling...
Sep 20 11:28:07 blackbox anacron[13799]: Anacron 2.3 started on 2011-09-20
Sep 20 11:28:07 blackbox anacron[13799]: Normal exit (0 jobs run)
Sep 20 11:28:07 blackbox kernel: [ 6834.435396] EXT4-fs (sdc): re-mounted. 
Opts: discard,data=ordered,errors=remount-ro,commit=0
Sep 20 11:28:07 blackbox kernel: [ 6834.666554] PM: Syncing filesystems ... 
done.
Sep 20 11:28:07 blackbox kernel: [ 6834.724441] PM: Preparing system for mem 
sleep
Sep 20 11:55:47 blackbox acpid: client 2070[0:0] has disconnected
Sep 20 11:55:47 blackbox kernel: [ 6834.760206] Freezing user space processes 
... 
Sep 20 11:55:47 blackbox kernel: [ 6837.528247] ata4.00: exception Emask 0x0 
SAct 0x1 SErr 0x0 action 0x6 frozen
Sep 20 11:55:47 blackbox kernel: [ 6837.528255] ata4.00: failed command: READ 
FPDMA QUEUED
Sep 20 11:55:47 blackbox kernel: [ 6837.528263] ata4.00: cmd 
60/40:00:b5:d4:6f/00:00:2b:00:00/40 tag 0 ncq 32768 in
Sep 20 11:55:47 blackbox kernel: [ 6837.528264]          res 
50/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
Sep 20 11:55:47 blackbox kernel: [ 6837.528271] ata4.00: status: { DRDY }
Sep 20 11:55:47 blackbox kernel: [ 6837.528278] ata4: hard resetting link
Sep 20 11:55:47 blackbox kernel: [ 6841.492022] ata4: SATA link up 3.0 Gbps 
(SStatus 123 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6841.496846] ata4.00: configured for 
UDMA/133
Sep 20 11:55:47 blackbox kernel: [ 6841.512032] ata4: EH complete
Sep 20 11:55:47 blackbox NetworkManager[1510]: <info> (eth0): carrier now OFF 
(device state 1)
Sep 20 11:55:47 blackbox NetworkManager[1510]: <info> (eth0): carrier now ON 
(device state 1)
Sep 20 11:55:47 blackbox kernel: [ 6841.544025] (elapsed 6.78 seconds) done.
Sep 20 11:55:47 blackbox kernel: [ 6841.544027] Freezing remaining freezable 
tasks ... (elapsed 0.01 seconds) done.
Sep 20 11:55:47 blackbox kernel: [ 6841.560029] PM: Entering mem sleep
Sep 20 11:55:47 blackbox kernel: [ 6841.560057] Suspending console(s) (use 
no_console_suspend to debug)
Sep 20 11:55:47 blackbox kernel: [ 6841.560407] sd 4:0:0:0: [sdc] 
Synchronizing SCSI cache
Sep 20 11:55:47 blackbox kernel: [ 6841.560438] sd 4:0:0:0: [sdc] Stopping 
disk
Sep 20 11:55:47 blackbox kernel: [ 6841.560463] sd 3:0:0:0: [sdb] Stopping 
disk
Sep 20 11:55:47 blackbox kernel: [ 6841.560565] sd 0:0:0:0: [sda] Stopping 
disk
Sep 20 11:55:47 blackbox kernel: [ 6841.564065] i8042 aux 00:0c: wake-up 
capability disabled by ACPI
Sep 20 11:55:47 blackbox kernel: [ 6841.564070] i8042 kbd 00:0b: wake-up 
capability enabled by ACPI
Sep 20 11:55:47 blackbox kernel: [ 6841.564398] serial 00:09: disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564402] serial 00:09: wake-up 
capability disabled by ACPI
Sep 20 11:55:47 blackbox kernel: [ 6841.564571] ehci_hcd 0000:00:1d.7: PCI INT 
A disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564586] uhci_hcd 0000:00:1d.2: PCI INT 
C disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564589] uhci_hcd 0000:00:1d.1: PCI INT 
B disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564595] uhci_hcd 0000:00:1d.0: PCI INT 
A disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564648] uhci_hcd 0000:00:1a.2: PCI INT 
C disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.564674] uhci_hcd 0000:00:1a.0: PCI INT 
A disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.565603] pata_jmicron 0000:02:00.0: PCI 
INT A disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.572054] ACPI handle has no context!
Sep 20 11:55:47 blackbox kernel: [ 6841.576046] uhci_hcd 0000:00:1a.1: PCI INT 
B disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.668076] HDA Intel 0000:00:1b.0: PCI 
INT A disabled
Sep 20 11:55:47 blackbox kernel: [ 6841.668103] ACPI handle has no context!
Sep 20 11:55:47 blackbox kernel: [ 6841.692027] ehci_hcd 0000:00:1a.7: PCI INT 
C disabled
Sep 20 11:55:47 blackbox kernel: [ 6842.008070] PM: suspend of devices 
complete after 447.720 msecs
Sep 20 11:55:47 blackbox kernel: [ 6842.056111] PM: late suspend of devices 
complete after 48.037 msecs
Sep 20 11:55:47 blackbox kernel: [ 6842.056521] ACPI: Preparing to enter 
system sleep state S3
Sep 20 11:55:47 blackbox kernel: [ 6842.056737] PM: Saving platform NVS memory
Sep 20 11:55:47 blackbox kernel: [ 6842.057248] Disabling non-boot CPUs ...
Sep 20 11:55:47 blackbox kernel: [ 6842.160028] CPU 1 is now offline
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] Extended CMOS year: 2000
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] ACPI: Low-level resume 
complete
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] PM: Restoring platform NVS 
memory
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] Extended CMOS year: 2000
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] Enabling non-boot CPUs ...
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] Booting Node 0 Processor 1 
APIC 0x1
Sep 20 11:55:47 blackbox kernel: [ 6842.160399] smpboot cpu 1: start_ip = 
9a000
Sep 20 11:55:47 blackbox kernel: [ 6842.058461] Initializing CPU#1
Sep 20 11:55:47 blackbox kernel: [ 6842.058461] Disabled fast string 
operations
Sep 20 11:55:47 blackbox kernel: [ 6842.268267] NMI watchdog enabled, takes 
one hw-pmu counter.
Sep 20 11:55:47 blackbox kernel: [ 6842.272012] Switched to NOHz mode on CPU 
#1
Sep 20 11:55:47 blackbox kernel: [ 6842.272040] CPU1 is up
Sep 20 11:55:47 blackbox kernel: [ 6842.273238] ACPI: Waking up from system 
sleep state S3
Sep 20 11:55:47 blackbox kernel: [ 6842.273690] agpgart-intel 0000:00:00.0: 
restoring config space at offset 0x1 (was 0x20900006, writing 0x80900006)
Sep 20 11:55:47 blackbox kernel: [ 6842.273703] i915 0000:00:02.0: restoring 
config space at offset 0x8 (was 0x1, writing 0xcc01)
Sep 20 11:55:47 blackbox kernel: [ 6842.273709] i915 0000:00:02.0: restoring 
config space at offset 0x1 (was 0x900007, writing 0x900407)
Sep 20 11:55:47 blackbox kernel: [ 6842.273726] pci 0000:00:02.1: restoring 
config space at offset 0x4 (was 0x0, writing 0xfe900000)
Sep 20 11:55:47 blackbox kernel: [ 6842.273730] pci 0000:00:02.1: restoring 
config space at offset 0x1 (was 0x900000, writing 0x900007)
Sep 20 11:55:47 blackbox kernel: [ 6842.273752] uhci_hcd 0000:00:1a.0: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.273776] uhci_hcd 0000:00:1a.1: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.273801] uhci_hcd 0000:00:1a.2: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.273831] ehci_hcd 0000:00:1a.7: 
restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002)
Sep 20 11:55:47 blackbox kernel: [ 6842.273863] HDA Intel 0000:00:1b.0: 
restoring config space at offset 0x1 (was 0x100006, writing 0x100002)
Sep 20 11:55:47 blackbox kernel: [ 6842.273881] pcieport 0000:00:1c.0: 
restoring config space at offset 0xf (was 0x20100, writing 0x2010a)
Sep 20 11:55:47 blackbox kernel: [ 6842.273890] pcieport 0000:00:1c.0: 
restoring config space at offset 0x8 (was 0xfff0, writing 0xf090f060)
Sep 20 11:55:47 blackbox kernel: [ 6842.273893] pcieport 0000:00:1c.0: 
restoring config space at offset 0x7 (was 0x200000f0, writing 0x20002020)
Sep 20 11:55:47 blackbox kernel: [ 6842.273901] pcieport 0000:00:1c.0: 
restoring config space at offset 0x1 (was 0x100106, writing 0x100507)
Sep 20 11:55:47 blackbox kernel: [ 6842.273928] pcieport 0000:00:1c.4: 
restoring config space at offset 0xf (was 0x20100, writing 0x2010a)
Sep 20 11:55:47 blackbox kernel: [ 6842.273936] pcieport 0000:00:1c.4: 
restoring config space at offset 0x9 (was 0x1fff1, writing 0xf051f041)
Sep 20 11:55:47 blackbox kernel: [ 6842.273940] pcieport 0000:00:1c.4: 
restoring config space at offset 0x8 (was 0xfff0, writing 0xf030f020)
Sep 20 11:55:47 blackbox kernel: [ 6842.273948] pcieport 0000:00:1c.4: 
restoring config space at offset 0x1 (was 0x100105, writing 0x100507)
Sep 20 11:55:47 blackbox kernel: [ 6842.273976] pcieport 0000:00:1c.5: 
restoring config space at offset 0xf (was 0x20200, writing 0x2020b)
Sep 20 11:55:47 blackbox kernel: [ 6842.273983] pcieport 0000:00:1c.5: 
restoring config space at offset 0x9 (was 0x1fff1, writing 0xf011f001)
Sep 20 11:55:47 blackbox kernel: [ 6842.273988] pcieport 0000:00:1c.5: 
restoring config space at offset 0x7 (was 0xf0, writing 0x1010)
Sep 20 11:55:47 blackbox kernel: [ 6842.273995] pcieport 0000:00:1c.5: 
restoring config space at offset 0x1 (was 0x100106, writing 0x100507)
Sep 20 11:55:47 blackbox kernel: [ 6842.274031] uhci_hcd 0000:00:1d.0: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.274055] uhci_hcd 0000:00:1d.1: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.274079] uhci_hcd 0000:00:1d.2: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 11:55:47 blackbox kernel: [ 6842.274110] ehci_hcd 0000:00:1d.7: 
restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002)
Sep 20 11:55:47 blackbox kernel: [ 6842.274126] pci 0000:00:1e.0: restoring 
config space at offset 0xf (was 0x20000, writing 0x200ff)
Sep 20 11:55:47 blackbox kernel: [ 6842.274135] pci 0000:00:1e.0: restoring 
config space at offset 0x7 (was 0x2280e0e0, writing 0xa280e0e0)
Sep 20 11:55:47 blackbox kernel: [ 6842.274193] ahci 0000:00:1f.2: restoring 
config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
Sep 20 11:55:47 blackbox kernel: [ 6842.274301] atl1 0000:01:00.0: restoring 
config space at offset 0xf (was 0x100, writing 0x10a)
Sep 20 11:55:47 blackbox kernel: [ 6842.274309] atl1 0000:01:00.0: restoring 
config space at offset 0xc (was 0x0, writing 0xfeaa0000)
Sep 20 11:55:47 blackbox kernel: [ 6842.274324] atl1 0000:01:00.0: restoring 
config space at offset 0x3 (was 0x0, writing 0x8)
Sep 20 11:55:47 blackbox kernel: [ 6842.274330] atl1 0000:01:00.0: restoring 
config space at offset 0x1 (was 0x100000, writing 0x100006)
Sep 20 11:55:47 blackbox kernel: [ 6842.274348] parport_serial 0000:04:00.0: 
restoring config space at offset 0xf (was 0x1ff, writing 0x10b)
Sep 20 11:55:47 blackbox kernel: [ 6842.274358] parport_serial 0000:04:00.0: 
restoring config space at offset 0x9 (was 0x1, writing 0xe081)
Sep 20 11:55:47 blackbox kernel: [ 6842.274362] parport_serial 0000:04:00.0: 
restoring config space at offset 0x8 (was 0x1, writing 0xe401)
Sep 20 11:55:47 blackbox kernel: [ 6842.274366] parport_serial 0000:04:00.0: 
restoring config space at offset 0x7 (was 0x1, writing 0xe481)
Sep 20 11:55:47 blackbox kernel: [ 6842.274371] parport_serial 0000:04:00.0: 
restoring config space at offset 0x6 (was 0x1, writing 0xe801)
Sep 20 11:55:47 blackbox kernel: [ 6842.274375] parport_serial 0000:04:00.0: 
restoring config space at offset 0x5 (was 0x1, writing 0xe881)
Sep 20 11:55:47 blackbox kernel: [ 6842.274379] parport_serial 0000:04:00.0: 
restoring config space at offset 0x4 (was 0x1, writing 0xec01)
Sep 20 11:55:47 blackbox acpid: client connected from 2070[0:0]
Sep 20 11:55:47 blackbox acpid: 1 client rule loaded
Sep 20 11:55:47 blackbox kernel: [ 6842.274384] parport_serial 0000:04:00.0: 
restoring config space at offset 0x3 (was 0x8, writing 0x4008)
Sep 20 11:55:47 blackbox kernel: [ 6842.274389] parport_serial 0000:04:00.0: 
restoring config space at offset 0x1 (was 0x2800000, writing 0x2800003)
Sep 20 11:55:47 blackbox kernel: [ 6842.274516] PM: early resume of devices 
complete after 0.859 msecs
Sep 20 11:55:47 blackbox kernel: [ 6842.274672] i915 0000:00:02.0: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274754] uhci_hcd 0000:00:1a.0: PCI INT 
A -> GSI 16 (level, low) -> IRQ 16
Sep 20 11:55:47 blackbox kernel: [ 6842.274758] uhci_hcd 0000:00:1a.0: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274777] usb usb3: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.274787] uhci_hcd 0000:00:1a.1: PCI INT 
B -> GSI 21 (level, low) -> IRQ 21
Sep 20 11:55:47 blackbox kernel: [ 6842.274791] uhci_hcd 0000:00:1a.1: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274809] usb usb4: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.274817] uhci_hcd 0000:00:1a.2: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 11:55:47 blackbox kernel: [ 6842.274821] uhci_hcd 0000:00:1a.2: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274839] usb usb5: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.274848] ehci_hcd 0000:00:1a.7: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 11:55:47 blackbox kernel: [ 6842.274853] ehci_hcd 0000:00:1a.7: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274887] HDA Intel 0000:00:1b.0: PCI 
INT A -> GSI 22 (level, low) -> IRQ 22
Sep 20 11:55:47 blackbox kernel: [ 6842.274891] HDA Intel 0000:00:1b.0: 
setting latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274916] HDA Intel 0000:00:1b.0: irq 45 
for MSI/MSI-X
Sep 20 11:55:47 blackbox kernel: [ 6842.274945] uhci_hcd 0000:00:1d.0: PCI INT 
A -> GSI 23 (level, low) -> IRQ 23
Sep 20 11:55:47 blackbox kernel: [ 6842.274950] uhci_hcd 0000:00:1d.0: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274968] usb usb6: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.274976] uhci_hcd 0000:00:1d.1: PCI INT 
B -> GSI 19 (level, low) -> IRQ 19
Sep 20 11:55:47 blackbox kernel: [ 6842.274980] uhci_hcd 0000:00:1d.1: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.274998] usb usb7: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.275006] uhci_hcd 0000:00:1d.2: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 11:55:47 blackbox kernel: [ 6842.275010] uhci_hcd 0000:00:1d.2: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.275028] usb usb8: root hub lost power 
or was reset
Sep 20 11:55:47 blackbox kernel: [ 6842.275037] ehci_hcd 0000:00:1d.7: PCI INT 
A -> GSI 23 (level, low) -> IRQ 23
Sep 20 11:55:47 blackbox kernel: [ 6842.275042] ehci_hcd 0000:00:1d.7: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.275072] pci 0000:00:1e.0: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.275081] ahci 0000:00:1f.2: setting 
latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.275121] pata_jmicron 0000:02:00.0: PCI 
INT A -> GSI 16 (level, low) -> IRQ 16
Sep 20 11:55:47 blackbox kernel: [ 6842.275126] pata_jmicron 0000:02:00.0: 
setting latency timer to 64
Sep 20 11:55:47 blackbox kernel: [ 6842.276113] serial 00:09: activated
Sep 20 11:55:47 blackbox kernel: [ 6842.276120] i8042 kbd 00:0b: wake-up 
capability disabled by ACPI
Sep 20 11:55:47 blackbox kernel: [ 6842.279170] Extended CMOS year: 2000
Sep 20 11:55:47 blackbox kernel: [ 6842.280270] atl1 0000:01:00.0: irq 46 for 
MSI/MSI-X
Sep 20 11:55:47 blackbox kernel: [ 6842.280311] atl1 0000:01:00.0: eth0 link 
is up 100 Mbps full duplex
Sep 20 11:55:47 blackbox kernel: [ 6842.283682] sd 0:0:0:0: [sda] Starting 
disk
Sep 20 11:55:47 blackbox kernel: [ 6842.283839] sd 3:0:0:0: [sdb] Starting 
disk
Sep 20 11:55:47 blackbox kernel: [ 6842.283875] sd 4:0:0:0: [sdc] Starting 
disk
Sep 20 11:55:47 blackbox kernel: [ 6842.340103] firewire_core: skipped bus 
generations, destroying all nodes
Sep 20 11:55:47 blackbox kernel: [ 6842.513047] No ACPI video bus found
Sep 20 11:55:47 blackbox kernel: [ 6842.616025] ata7: SATA link down (SStatus 
0 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6842.624024] ata8: SATA link down (SStatus 
0 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6842.632023] ata6: SATA link down (SStatus 
0 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6842.764026] usb 4-2: reset low speed USB 
device number 2 using uhci_hcd
Sep 20 11:55:47 blackbox kernel: [ 6842.780022] ata5: SATA link up 3.0 Gbps 
(SStatus 123 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6842.820021] ata3: SATA link up 1.5 Gbps 
(SStatus 113 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6842.826565] ata3.00: configured for 
UDMA/100
Sep 20 11:55:47 blackbox kernel: [ 6842.840039] firewire_core: rediscovered 
device fw0
Sep 20 11:55:47 blackbox kernel: [ 6843.160711] ata5.00: configured for 
UDMA/133
Sep 20 11:55:47 blackbox kernel: [ 6847.312019] ata1: link is slow to respond, 
please be patient (ready=0)
Sep 20 11:55:47 blackbox kernel: [ 6849.100502] ata1.00: ACPI cmd 
ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Sep 20 11:55:47 blackbox kernel: [ 6849.100505] ata1.00: ACPI cmd 
ef/03:46:00:00:00:a0 (SET FEATURES) filtered out
Sep 20 11:55:47 blackbox kernel: [ 6849.100508] ata1.00: ACPI cmd 
f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
Sep 20 11:55:47 blackbox kernel: [ 6849.116723] ata1.00: configured for 
UDMA/100
Sep 20 11:55:47 blackbox kernel: [ 6849.136945] sd 0:0:0:0: [sda] Write cache: 
enabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 11:55:47 blackbox kernel: [ 6849.604021] ata4: SATA link up 3.0 Gbps 
(SStatus 123 SControl 300)
Sep 20 11:55:47 blackbox kernel: [ 6849.626593] ata4.00: configured for 
UDMA/133
Sep 20 11:55:47 blackbox kernel: [ 6849.640111] sd 3:0:0:0: [sdb] Write cache: 
enabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 11:55:47 blackbox kernel: [ 6849.647478] PM: resume of devices complete 
after 7372.822 msecs
Sep 20 11:55:47 blackbox kernel: [ 6849.647642] PM: Finishing wakeup.
Sep 20 11:55:47 blackbox kernel: [ 6849.647643] Restarting tasks ... done.
Sep 20 11:55:47 blackbox kernel: [ 6850.023990] ata1.00: configured for 
UDMA/100
Sep 20 11:55:47 blackbox kernel: [ 6850.023995] ata1: EH complete
Sep 20 11:55:47 blackbox kernel: [ 6850.025191] sd 0:0:0:0: [sda] Write cache: 
disabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 11:55:48 blackbox dbus[1313]: [system] Activating service 
name='org.kde.powerdevil.backlighthelper' (using servicehelper)
Sep 20 11:55:48 blackbox kernel: [ 6850.237355] ata4.00: configured for 
UDMA/133
Sep 20 11:55:48 blackbox kernel: [ 6850.237359] ata4: EH complete
Sep 20 11:55:48 blackbox kernel: [ 6850.247835] sd 3:0:0:0: [sdb] Write cache: 
disabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 11:55:48 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 11:55:48 blackbox anacron[14013]: Anacron 2.3 started on 2011-09-20
Sep 20 11:55:48 blackbox anacron[14013]: Normal exit (0 jobs run)
Sep 20 11:55:48 blackbox NetworkManager[1510]: <info> wake requested 
(sleeping: yes  enabled: yes)
Sep 20 11:55:48 blackbox NetworkManager[1510]: <info> waking up and re-
enabling...
Sep 20 11:55:48 blackbox anacron[14062]: Anacron 2.3 started on 2011-09-20
Sep 20 11:55:48 blackbox anacron[14062]: Normal exit (0 jobs run)
Sep 20 11:55:48 blackbox kernel: [ 6850.505117] EXT4-fs (sdc): re-mounted. 
Opts: discard,data=ordered,errors=remount-ro,commit=0
Sep 20 11:57:18 blackbox dbus[1313]: [system] Activating service 
name='org.kde.powerdevil.backlighthelper' (using servicehelper)
Sep 20 11:57:18 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 11:58:03 blackbox dbus[1313]: [system] Activating service 
name='org.kde.powerdevil.backlighthelper' (using servicehelper)
Sep 20 11:58:03 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 11:58:48 blackbox dbus[1313]: [system] Activating service 
name='org.kde.powerdevil.backlighthelper' (using servicehelper)
Sep 20 11:58:48 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 12:05:48 blackbox NetworkManager[1510]: <info> sleep requested 
(sleeping: no  enabled: yes)
Sep 20 12:05:48 blackbox NetworkManager[1510]: <info> sleeping or disabling...
Sep 20 12:05:49 blackbox anacron[14865]: Anacron 2.3 started on 2011-09-20
Sep 20 12:05:49 blackbox anacron[14865]: Normal exit (0 jobs run)
Sep 20 12:05:49 blackbox kernel: [ 7451.653891] EXT4-fs (sdc): re-mounted. 
Opts: discard,data=ordered,errors=remount-ro,commit=0
Sep 20 12:05:49 blackbox kernel: [ 7451.936258] PM: Syncing filesystems ... 
done.
Sep 20 12:05:49 blackbox kernel: [ 7451.994935] PM: Preparing system for mem 
sleep
Sep 20 12:07:14 blackbox acpid: client 2070[0:0] has disconnected
Sep 20 12:07:14 blackbox NetworkManager[1510]: <info> (eth0): carrier now OFF 
(device state 1)
Sep 20 12:07:14 blackbox NetworkManager[1510]: <info> (eth0): carrier now ON 
(device state 1)
Sep 20 12:07:14 blackbox kernel: [ 7452.052103] Freezing user space processes 
... (elapsed 0.01 seconds) done.
Sep 20 12:07:14 blackbox kernel: [ 7452.068054] Freezing remaining freezable 
tasks ... (elapsed 0.01 seconds) done.
Sep 20 12:07:14 blackbox kernel: [ 7452.084040] PM: Entering mem sleep
Sep 20 12:07:14 blackbox kernel: [ 7452.084070] Suspending console(s) (use 
no_console_suspend to debug)
Sep 20 12:07:14 blackbox kernel: [ 7452.084428] sd 4:0:0:0: [sdc] 
Synchronizing SCSI cache
Sep 20 12:07:14 blackbox kernel: [ 7452.084482] sd 3:0:0:0: [sdb] Stopping 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.084575] sd 0:0:0:0: [sda] Stopping 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.085220] sd 4:0:0:0: [sdc] Stopping 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.087909] i8042 aux 00:0c: wake-up 
capability disabled by ACPI
Sep 20 12:07:14 blackbox kernel: [ 7452.087914] i8042 kbd 00:0b: wake-up 
capability enabled by ACPI
Sep 20 12:07:14 blackbox kernel: [ 7452.088247] serial 00:09: disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088252] serial 00:09: wake-up 
capability disabled by ACPI
Sep 20 12:07:14 blackbox kernel: [ 7452.088421] ehci_hcd 0000:00:1d.7: PCI INT 
A disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088436] uhci_hcd 0000:00:1d.2: PCI INT 
C disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088440] uhci_hcd 0000:00:1d.1: PCI INT 
B disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088445] uhci_hcd 0000:00:1d.0: PCI INT 
A disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088517] uhci_hcd 0000:00:1a.2: PCI INT 
C disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.088543] uhci_hcd 0000:00:1a.0: PCI INT 
A disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.089614] pata_jmicron 0000:02:00.0: PCI 
INT A disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.096054] ACPI handle has no context!
Sep 20 12:07:14 blackbox kernel: [ 7452.100051] uhci_hcd 0000:00:1a.1: PCI INT 
B disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.192067] HDA Intel 0000:00:1b.0: PCI 
INT A disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.192094] ACPI handle has no context!
Sep 20 12:07:14 blackbox kernel: [ 7452.216027] ehci_hcd 0000:00:1a.7: PCI INT 
C disabled
Sep 20 12:07:14 blackbox kernel: [ 7452.528031] PM: suspend of devices 
complete after 443.664 msecs
Sep 20 12:07:14 blackbox kernel: [ 7452.576110] PM: late suspend of devices 
complete after 48.075 msecs
Sep 20 12:07:14 blackbox kernel: [ 7452.576519] ACPI: Preparing to enter 
system sleep state S3
Sep 20 12:07:14 blackbox kernel: [ 7452.576733] PM: Saving platform NVS memory
Sep 20 12:07:14 blackbox kernel: [ 7452.577170] Disabling non-boot CPUs ...
Sep 20 12:07:14 blackbox kernel: [ 7452.680022] CPU 1 is now offline
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] Extended CMOS year: 2000
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] ACPI: Low-level resume 
complete
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] PM: Restoring platform NVS 
memory
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] Extended CMOS year: 2000
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] Enabling non-boot CPUs ...
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] Booting Node 0 Processor 1 
APIC 0x1
Sep 20 12:07:14 blackbox kernel: [ 7452.680449] smpboot cpu 1: start_ip = 
9a000
Sep 20 12:07:14 blackbox kernel: [ 7452.578377] Initializing CPU#1
Sep 20 12:07:14 blackbox kernel: [ 7452.578377] Disabled fast string 
operations
Sep 20 12:07:14 blackbox kernel: [ 7452.788221] NMI watchdog enabled, takes 
one hw-pmu counter.
Sep 20 12:07:14 blackbox kernel: [ 7452.792012] Switched to NOHz mode on CPU 
#1
Sep 20 12:07:14 blackbox kernel: [ 7452.792040] CPU1 is up
Sep 20 12:07:14 blackbox kernel: [ 7452.793223] ACPI: Waking up from system 
sleep state S3
Sep 20 12:07:14 blackbox kernel: [ 7452.793678] agpgart-intel 0000:00:00.0: 
restoring config space at offset 0x1 (was 0x20900006, writing 0xa0900006)
Sep 20 12:07:14 blackbox kernel: [ 7452.793691] i915 0000:00:02.0: restoring 
config space at offset 0x8 (was 0x1, writing 0xcc01)
Sep 20 12:07:14 blackbox kernel: [ 7452.793696] i915 0000:00:02.0: restoring 
config space at offset 0x1 (was 0x900007, writing 0x900407)
Sep 20 12:07:14 blackbox kernel: [ 7452.793714] pci 0000:00:02.1: restoring 
config space at offset 0x4 (was 0x0, writing 0xfe900000)
Sep 20 12:07:14 blackbox kernel: [ 7452.793718] pci 0000:00:02.1: restoring 
config space at offset 0x1 (was 0x900000, writing 0x900007)
Sep 20 12:07:14 blackbox kernel: [ 7452.793740] uhci_hcd 0000:00:1a.0: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.793765] uhci_hcd 0000:00:1a.1: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.793789] uhci_hcd 0000:00:1a.2: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.793820] ehci_hcd 0000:00:1a.7: 
restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002)
Sep 20 12:07:14 blackbox kernel: [ 7452.793852] HDA Intel 0000:00:1b.0: 
restoring config space at offset 0x1 (was 0x100006, writing 0x100002)
Sep 20 12:07:14 blackbox kernel: [ 7452.793870] pcieport 0000:00:1c.0: 
restoring config space at offset 0xf (was 0x20100, writing 0x2010a)
Sep 20 12:07:14 blackbox kernel: [ 7452.793878] pcieport 0000:00:1c.0: 
restoring config space at offset 0x8 (was 0xfff0, writing 0xf090f060)
Sep 20 12:07:14 blackbox acpid: client connected from 2070[0:0]
Sep 20 12:07:14 blackbox acpid: 1 client rule loaded
Sep 20 12:07:14 blackbox kernel: [ 7452.793882] pcieport 0000:00:1c.0: 
restoring config space at offset 0x7 (was 0x200000f0, writing 0x2020)
Sep 20 12:07:14 blackbox kernel: [ 7452.793890] pcieport 0000:00:1c.0: 
restoring config space at offset 0x1 (was 0x100106, writing 0x100507)
Sep 20 12:07:14 blackbox kernel: [ 7452.793918] pcieport 0000:00:1c.4: 
restoring config space at offset 0xf (was 0x20100, writing 0x2010a)
Sep 20 12:07:14 blackbox kernel: [ 7452.793925] pcieport 0000:00:1c.4: 
restoring config space at offset 0x9 (was 0x1fff1, writing 0xf051f041)
Sep 20 12:07:14 blackbox kernel: [ 7452.793929] pcieport 0000:00:1c.4: 
restoring config space at offset 0x8 (was 0xfff0, writing 0xf030f020)
Sep 20 12:07:14 blackbox kernel: [ 7452.793937] pcieport 0000:00:1c.4: 
restoring config space at offset 0x1 (was 0x100105, writing 0x100507)
Sep 20 12:07:14 blackbox kernel: [ 7452.793965] pcieport 0000:00:1c.5: 
restoring config space at offset 0xf (was 0x20200, writing 0x2020b)
Sep 20 12:07:14 blackbox kernel: [ 7452.793972] pcieport 0000:00:1c.5: 
restoring config space at offset 0x9 (was 0x1fff1, writing 0xf011f001)
Sep 20 12:07:14 blackbox kernel: [ 7452.793977] pcieport 0000:00:1c.5: 
restoring config space at offset 0x7 (was 0xf0, writing 0x1010)
Sep 20 12:07:14 blackbox kernel: [ 7452.793984] pcieport 0000:00:1c.5: 
restoring config space at offset 0x1 (was 0x100106, writing 0x100507)
Sep 20 12:07:14 blackbox kernel: [ 7452.794021] uhci_hcd 0000:00:1d.0: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.794045] uhci_hcd 0000:00:1d.1: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.794069] uhci_hcd 0000:00:1d.2: 
restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001)
Sep 20 12:07:14 blackbox kernel: [ 7452.794100] ehci_hcd 0000:00:1d.7: 
restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002)
Sep 20 12:07:14 blackbox kernel: [ 7452.794116] pci 0000:00:1e.0: restoring 
config space at offset 0xf (was 0x20000, writing 0x200ff)
Sep 20 12:07:14 blackbox kernel: [ 7452.794125] pci 0000:00:1e.0: restoring 
config space at offset 0x7 (was 0x2280e0e0, writing 0xa280e0e0)
Sep 20 12:07:14 blackbox kernel: [ 7452.794184] ahci 0000:00:1f.2: restoring 
config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
Sep 20 12:07:14 blackbox kernel: [ 7452.794292] atl1 0000:01:00.0: restoring 
config space at offset 0xf (was 0x100, writing 0x10a)
Sep 20 12:07:14 blackbox kernel: [ 7452.794299] atl1 0000:01:00.0: restoring 
config space at offset 0xc (was 0x0, writing 0xfeaa0000)
Sep 20 12:07:14 blackbox kernel: [ 7452.794314] atl1 0000:01:00.0: restoring 
config space at offset 0x3 (was 0x0, writing 0x8)
Sep 20 12:07:14 blackbox kernel: [ 7452.794320] atl1 0000:01:00.0: restoring 
config space at offset 0x1 (was 0x100000, writing 0x100006)
Sep 20 12:07:14 blackbox kernel: [ 7452.794339] parport_serial 0000:04:00.0: 
restoring config space at offset 0xf (was 0x1ff, writing 0x10b)
Sep 20 12:07:14 blackbox kernel: [ 7452.794348] parport_serial 0000:04:00.0: 
restoring config space at offset 0x9 (was 0x1, writing 0xe081)
Sep 20 12:07:14 blackbox kernel: [ 7452.794353] parport_serial 0000:04:00.0: 
restoring config space at offset 0x8 (was 0x1, writing 0xe401)
Sep 20 12:07:14 blackbox kernel: [ 7452.794357] parport_serial 0000:04:00.0: 
restoring config space at offset 0x7 (was 0x1, writing 0xe481)
Sep 20 12:07:14 blackbox kernel: [ 7452.794361] parport_serial 0000:04:00.0: 
restoring config space at offset 0x6 (was 0x1, writing 0xe801)
Sep 20 12:07:14 blackbox kernel: [ 7452.794366] parport_serial 0000:04:00.0: 
restoring config space at offset 0x5 (was 0x1, writing 0xe881)
Sep 20 12:07:14 blackbox kernel: [ 7452.794370] parport_serial 0000:04:00.0: 
restoring config space at offset 0x4 (was 0x1, writing 0xec01)
Sep 20 12:07:14 blackbox kernel: [ 7452.794374] parport_serial 0000:04:00.0: 
restoring config space at offset 0x3 (was 0x8, writing 0x4008)
Sep 20 12:07:14 blackbox kernel: [ 7452.794380] parport_serial 0000:04:00.0: 
restoring config space at offset 0x1 (was 0x2800000, writing 0x2800003)
Sep 20 12:07:14 blackbox kernel: [ 7452.794507] PM: early resume of devices 
complete after 0.863 msecs
Sep 20 12:07:14 blackbox kernel: [ 7452.794664] i915 0000:00:02.0: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794745] uhci_hcd 0000:00:1a.0: PCI INT 
A -> GSI 16 (level, low) -> IRQ 16
Sep 20 12:07:14 blackbox kernel: [ 7452.794749] uhci_hcd 0000:00:1a.0: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794769] usb usb3: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.794778] uhci_hcd 0000:00:1a.1: PCI INT 
B -> GSI 21 (level, low) -> IRQ 21
Sep 20 12:07:14 blackbox kernel: [ 7452.794782] uhci_hcd 0000:00:1a.1: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794800] usb usb4: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.794808] uhci_hcd 0000:00:1a.2: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 12:07:14 blackbox kernel: [ 7452.794813] uhci_hcd 0000:00:1a.2: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794831] usb usb5: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.794840] ehci_hcd 0000:00:1a.7: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 12:07:14 blackbox kernel: [ 7452.794845] ehci_hcd 0000:00:1a.7: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794879] HDA Intel 0000:00:1b.0: PCI 
INT A -> GSI 22 (level, low) -> IRQ 22
Sep 20 12:07:14 blackbox kernel: [ 7452.794883] HDA Intel 0000:00:1b.0: 
setting latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794908] HDA Intel 0000:00:1b.0: irq 45 
for MSI/MSI-X
Sep 20 12:07:14 blackbox kernel: [ 7452.794938] uhci_hcd 0000:00:1d.0: PCI INT 
A -> GSI 23 (level, low) -> IRQ 23
Sep 20 12:07:14 blackbox kernel: [ 7452.794942] uhci_hcd 0000:00:1d.0: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794960] usb usb6: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.794968] uhci_hcd 0000:00:1d.1: PCI INT 
B -> GSI 19 (level, low) -> IRQ 19
Sep 20 12:07:14 blackbox kernel: [ 7452.794973] uhci_hcd 0000:00:1d.1: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.794991] usb usb7: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.794998] uhci_hcd 0000:00:1d.2: PCI INT 
C -> GSI 18 (level, low) -> IRQ 18
Sep 20 12:07:14 blackbox kernel: [ 7452.795003] uhci_hcd 0000:00:1d.2: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.795021] usb usb8: root hub lost power 
or was reset
Sep 20 12:07:14 blackbox kernel: [ 7452.795030] ehci_hcd 0000:00:1d.7: PCI INT 
A -> GSI 23 (level, low) -> IRQ 23
Sep 20 12:07:14 blackbox kernel: [ 7452.795035] ehci_hcd 0000:00:1d.7: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.795065] pci 0000:00:1e.0: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.795074] ahci 0000:00:1f.2: setting 
latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.795115] pata_jmicron 0000:02:00.0: PCI 
INT A -> GSI 16 (level, low) -> IRQ 16
Sep 20 12:07:14 blackbox kernel: [ 7452.795120] pata_jmicron 0000:02:00.0: 
setting latency timer to 64
Sep 20 12:07:14 blackbox kernel: [ 7452.796108] serial 00:09: activated
Sep 20 12:07:14 blackbox kernel: [ 7452.796115] i8042 kbd 00:0b: wake-up 
capability disabled by ACPI
Sep 20 12:07:14 blackbox kernel: [ 7452.799268] Extended CMOS year: 2000
Sep 20 12:07:14 blackbox kernel: [ 7452.800275] atl1 0000:01:00.0: irq 46 for 
MSI/MSI-X
Sep 20 12:07:14 blackbox kernel: [ 7452.800316] atl1 0000:01:00.0: eth0 link 
is up 100 Mbps full duplex
Sep 20 12:07:14 blackbox kernel: [ 7452.802039] sd 0:0:0:0: [sda] Starting 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.802194] sd 3:0:0:0: [sdb] Starting 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.802230] sd 4:0:0:0: [sdc] Starting 
disk
Sep 20 12:07:14 blackbox kernel: [ 7452.860108] firewire_core: skipped bus 
generations, destroying all nodes
Sep 20 12:07:14 blackbox kernel: [ 7453.041058] No ACPI video bus found
Sep 20 12:07:14 blackbox kernel: [ 7453.136025] ata6: SATA link down (SStatus 
0 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7453.144024] ata8: SATA link down (SStatus 
0 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7453.152023] ata7: SATA link down (SStatus 
0 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7453.284022] ata3: SATA link up 1.5 Gbps 
(SStatus 113 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7453.284146] usb 4-2: reset low speed USB 
device number 2 using uhci_hcd
Sep 20 12:07:14 blackbox kernel: [ 7453.290595] ata3.00: configured for 
UDMA/100
Sep 20 12:07:14 blackbox kernel: [ 7453.300022] ata5: SATA link up 3.0 Gbps 
(SStatus 123 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7453.360039] firewire_core: rediscovered 
device fw0
Sep 20 12:07:14 blackbox kernel: [ 7453.849406] ata5.00: configured for 
UDMA/133
Sep 20 12:07:14 blackbox kernel: [ 7457.832019] ata1: link is slow to respond, 
please be patient (ready=0)
Sep 20 12:07:14 blackbox kernel: [ 7459.580499] ata1.00: ACPI cmd 
ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Sep 20 12:07:14 blackbox kernel: [ 7459.580502] ata1.00: ACPI cmd 
ef/03:46:00:00:00:a0 (SET FEATURES) filtered out
Sep 20 12:07:14 blackbox kernel: [ 7459.580504] ata1.00: ACPI cmd 
f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
Sep 20 12:07:14 blackbox kernel: [ 7459.596697] ata1.00: configured for 
UDMA/100
Sep 20 12:07:14 blackbox kernel: [ 7459.616626] sd 0:0:0:0: [sda] Write cache: 
enabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 12:07:14 blackbox kernel: [ 7460.124021] ata4: SATA link up 3.0 Gbps 
(SStatus 123 SControl 300)
Sep 20 12:07:14 blackbox kernel: [ 7460.146592] ata4.00: configured for 
UDMA/133
Sep 20 12:07:14 blackbox kernel: [ 7460.160110] sd 3:0:0:0: [sdb] Write cache: 
enabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 12:07:14 blackbox kernel: [ 7460.166972] PM: resume of devices complete 
after 7372.323 msecs
Sep 20 12:07:14 blackbox kernel: [ 7460.167127] PM: Finishing wakeup.
Sep 20 12:07:14 blackbox kernel: [ 7460.167128] Restarting tasks ... done.
Sep 20 12:07:14 blackbox dbus[1313]: [system] Activating service 
name='org.kde.powerdevil.backlighthelper' (using servicehelper)
Sep 20 12:07:14 blackbox kernel: [ 7460.520731] ata1.00: configured for 
UDMA/100
Sep 20 12:07:14 blackbox kernel: [ 7460.520736] ata1: EH complete
Sep 20 12:07:14 blackbox kernel: [ 7460.521587] sd 0:0:0:0: [sda] Write cache: 
disabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 12:07:14 blackbox dbus[1313]: [system] Successfully activated service 
'org.kde.powerdevil.backlighthelper'
Sep 20 12:07:14 blackbox kernel: [ 7460.764625] ata4.00: configured for 
UDMA/133
Sep 20 12:07:14 blackbox kernel: [ 7460.764629] ata4: EH complete
Sep 20 12:07:14 blackbox kernel: [ 7460.764739] sd 3:0:0:0: [sdb] Write cache: 
disabled, read cache: enabled, doesn't support DPO or FUA
Sep 20 12:07:14 blackbox anacron[15074]: Anacron 2.3 started on 2011-09-20
Sep 20 12:07:14 blackbox anacron[15074]: Normal exit (0 jobs run)
Sep 20 12:07:14 blackbox NetworkManager[1510]: <info> wake requested 
(sleeping: yes  enabled: yes)
Sep 20 12:07:14 blackbox NetworkManager[1510]: <info> waking up and re-
enabling...
Sep 20 12:07:14 blackbox anacron[15123]: Anacron 2.3 started on 2011-09-20
Sep 20 12:07:14 blackbox anacron[15123]: Normal exit (0 jobs run)
Sep 20 12:07:14 blackbox kernel: [ 7461.055172] EXT4-fs (sdc): re-mounted. 
Opts: discard,data=ordered,errors=remount-ro,commit=0
blackbox:~# 


Thanks,
Rainer

-- 
Rainer Dorsch
http://bokomoko.de/

^ permalink raw reply	[flat|nested] 2+ messages in thread

* Re: xserver-xorg-video-intel does sometimes not resume
  2011-09-20 10:41 xserver-xorg-video-intel does sometimes not resume Rainer Dorsch
@ 2011-09-20 16:49 ` Keith Packard
  0 siblings, 0 replies; 2+ messages in thread
From: Keith Packard @ 2011-09-20 16:49 UTC (permalink / raw)
  To: Rainer Dorsch, intel-gfx


[-- Attachment #1.1: Type: text/plain, Size: 1098 bytes --]

On Tue, 20 Sep 2011 12:41:16 +0200, Rainer Dorsch <ml@bokomoko.de> wrote:

> I am wondering what I could do to figure out the root cause of the problem. I 
> forgot to try, but I assume, that I could ssh into the machine and do some 
> diagnosis, when the problem occurs. Are there logs which could help? I attach 
> the syslog below...

Are you running the current 3.0.0 kernel from testing?

A kernel log with drm debug parameter set to 5 would be ideal; that will
show all of the mode setting logic happening at resume time which is
presumably not working. Two sessions, one working and one not working
would make identifying trouble easier.

You can set the drm debug parameter with a kernel command line option

        drm.debug=5

Second, the output of 'intel_reg_dumper', which doesn't appear to be
packaged for debian yet. That's available from:

git://anongit.freedesktop.org/git/xorg/app/intel-gpu-tools

Again, having both working and non-working output makes it easy to
identify any differences which may point out the problem.

-- 
keith.packard@intel.com

[-- Attachment #1.2: Type: application/pgp-signature, Size: 189 bytes --]

[-- Attachment #2: Type: text/plain, Size: 159 bytes --]

_______________________________________________
Intel-gfx mailing list
Intel-gfx@lists.freedesktop.org
http://lists.freedesktop.org/mailman/listinfo/intel-gfx

^ permalink raw reply	[flat|nested] 2+ messages in thread

end of thread, other threads:[~2011-09-20 16:49 UTC | newest]

Thread overview: 2+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2011-09-20 10:41 xserver-xorg-video-intel does sometimes not resume Rainer Dorsch
2011-09-20 16:49 ` Keith Packard

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.