Error: command ['sh', '-c', 'dmesg | comm -13 /var/log/dmesg -'] failed with exit code 1: [ 21.726054] alloc irq_desc for 27 on node 0 [ 21.726057] alloc kstat_irqs on node 0 [ 21.726070] ATL1E 0000:02:00.0: irq 27 for MSI/MSI-X [ 21.726205] ATL1E 0000:02:00.0: ATL1E: eth0 NIC Link is Up<1000 Mbps Full Duplex> [ 21.726512] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 21.726892] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 23.890058] ppdev: user-space parallel port driver [ 32.668019] eth0: no IPv6 routers present comm: file 2 is not in sorted order [ 3174.212214] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 3178.208193] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 3718.216081] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 4292.216661] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 4298.240110] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 4316.212196] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 4866.220202] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 5422.212186] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [ 6920.204125] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [11294.228153] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [13138.220200] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [14576.220232] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [14726.220195] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [15174.208209] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [16460.224141] usb 2-5.6: reset high speed USB device using ehci_hcd and address 5 [16497.085025] PM: Syncing filesystems ... done. [16497.098965] PM: Preparing system for mem sleep [16497.098969] Freezing user space processes ... (elapsed 0.00 seconds) done. [16497.099890] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [16497.099946] PM: Entering mem sleep [16497.099958] Suspending console(s) (use no_console_suspend to debug) [16497.149550] sd 0:0:0:0: [sda] Synchronizing SCSI cache [16497.372747] sd 0:0:0:0: [sda] Stopping disk [16497.868262] ACPI handle has no context! [16497.868606] serial 00:0b: disabled [16497.872658] ACPI handle has no context! [16497.884077] ACPI handle has no context! [16497.884083] ATL1E 0000:02:00.0: PME# disabled [16497.884091] ATL1E 0000:02:00.0: PCI INT A disabled [16497.884098] ACPI handle has no context! [16497.948250] ata_piix 0000:00:1f.5: PCI INT B disabled [16497.960096] ata_piix 0000:00:1f.2: PCI INT B disabled [16497.976029] ehci_hcd 0000:00:1d.7: PCI INT A disabled [16497.976037] uhci_hcd 0000:00:1d.2: PCI INT C disabled [16497.976044] uhci_hcd 0000:00:1d.1: PCI INT B disabled [16497.976051] uhci_hcd 0000:00:1d.0: PCI INT A disabled [16498.080097] HDA Intel 0000:00:1b.0: PCI INT A disabled [16498.080136] ACPI handle has no context! [16498.096024] ehci_hcd 0000:00:1a.7: PCI INT C disabled [16498.096031] uhci_hcd 0000:00:1a.2: PCI INT C disabled [16498.096038] uhci_hcd 0000:00:1a.1: PCI INT B disabled [16498.096045] uhci_hcd 0000:00:1a.0: PCI INT A disabled [16498.096106] PM: suspend devices took 1.000 seconds [16498.096300] ehci_hcd 0000:00:1d.7: PME# disabled [16498.112204] ehci_hcd 0000:00:1a.7: PME# disabled [16498.128639] ACPI: Preparing to enter system sleep state S3 [16498.129274] Disabling non-boot CPUs ... [16498.132257] CPU 1 is now offline [16498.132577] CPU0 attaching NULL sched-domain. [16498.132582] CPU1 attaching NULL sched-domain. [16498.132583] CPU2 attaching NULL sched-domain. [16498.132585] CPU3 attaching NULL sched-domain. [16498.144041] CPU0 attaching sched-domain: [16498.144046] domain 0: span 0,2-3 level CPU [16498.144049] groups: 0 2-3 [16498.144055] CPU2 attaching sched-domain: [16498.144057] domain 0: span 2-3 level MC [16498.144060] groups: 2 3 [16498.144064] domain 1: span 0,2-3 level CPU [16498.144066] groups: 2-3 0 [16498.144071] CPU3 attaching sched-domain: [16498.144073] domain 0: span 2-3 level MC [16498.144076] groups: 3 2 [16498.144080] domain 1: span 0,2-3 level CPU [16498.144082] groups: 2-3 0 [16498.144536] CPU1 is down [16498.146671] CPU 2 is now offline [16498.146876] CPU0 attaching NULL sched-domain. [16498.146878] CPU2 attaching NULL sched-domain. [16498.146880] CPU3 attaching NULL sched-domain. [16498.156046] CPU0 attaching sched-domain: [16498.156049] domain 0: span 0,3 level CPU [16498.156051] groups: 0 3 [16498.156056] CPU3 attaching sched-domain: [16498.156058] domain 0: span 0,3 level CPU [16498.156061] groups: 3 0 [16498.156327] CPU2 is down [16498.260017] CPU 3 is now offline [16498.260019] SMP alternatives: switching to UP code [16498.265584] CPU0 attaching NULL sched-domain. [16498.265586] CPU3 attaching NULL sched-domain. [16498.265592] CPU0 attaching NULL sched-domain. [16498.265704] CPU3 is down [16498.265710] Back to C! [16498.265710] Enabling non-boot CPUs ... [16498.265710] SMP alternatives: switching to SMP code [16498.271131] Booting processor 1 APIC 0x1 ip 0x6000 [16498.132395] Initializing CPU#1 [16498.132395] Calibrating delay using timer specific routine.. 4799.34 BogoMIPS (lpj=9598696) [16498.132395] CPU: L1 I cache: 32K, L1 D cache: 32K [16498.132395] CPU: L2 cache: 4096K [16498.132395] CPU 1/0x1 -> Node 0 [16498.132395] CPU: Physical Processor ID: 0 [16498.132395] CPU: Processor Core ID: 1 [16498.360598] CPU1: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [16498.360605] checking TSC synchronization [CPU#0 -> CPU#1]: passed. [16498.380667] CPU0 attaching NULL sched-domain. [16498.384523] Switched to high resolution mode on CPU 1 [16498.396039] CPU0 attaching sched-domain: [16498.396043] domain 0: span 0-1 level MC [16498.396046] groups: 0 1 [16498.396051] CPU1 attaching sched-domain: [16498.396054] domain 0: span 0-1 level MC [16498.396056] groups: 1 0 [16498.396532] CPU1 is up [16498.396785] Booting processor 2 APIC 0x2 ip 0x6000 [16498.146751] Initializing CPU#2 [16498.146751] Calibrating delay using timer specific routine.. 4799.36 BogoMIPS (lpj=9598734) [16498.146751] CPU: L1 I cache: 32K, L1 D cache: 32K [16498.146751] CPU: L2 cache: 4096K [16498.146751] CPU 2/0x2 -> Node 0 [16498.146751] CPU: Physical Processor ID: 0 [16498.146751] CPU: Processor Core ID: 2 [16498.484558] CPU2: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [16498.484564] checking TSC synchronization [CPU#0 -> CPU#2]: passed. [16498.504599] CPU0 attaching NULL sched-domain. [16498.504601] CPU1 attaching NULL sched-domain. [16498.508018] Switched to high resolution mode on CPU 2 [16498.520039] CPU0 attaching sched-domain: [16498.520042] domain 0: span 0-1 level MC [16498.520045] groups: 0 1 [16498.520049] domain 1: span 0-2 level CPU [16498.520052] groups: 0-1 2 [16498.520057] CPU1 attaching sched-domain: [16498.520059] domain 0: span 0-1 level MC [16498.520061] groups: 1 0 [16498.520065] domain 1: span 0-2 level CPU [16498.520068] groups: 0-1 2 [16498.520073] CPU2 attaching sched-domain: [16498.520075] domain 0: span 0-2 level CPU [16498.520077] groups: 2 0-1 [16498.520590] CPU2 is up [16498.520939] Booting processor 3 APIC 0x3 ip 0x6000 [16498.265473] Initializing CPU#3 [16498.265473] Calibrating delay using timer specific routine.. 4799.37 BogoMIPS (lpj=9598744) [16498.265473] CPU: L1 I cache: 32K, L1 D cache: 32K [16498.265473] CPU: L2 cache: 4096K [16498.265473] CPU 3/0x3 -> Node 0 [16498.265473] CPU: Physical Processor ID: 0 [16498.265473] CPU: Processor Core ID: 3 [16498.608612] CPU3: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [16498.608617] checking TSC synchronization [CPU#0 -> CPU#3]: passed. [16498.628649] CPU0 attaching NULL sched-domain. [16498.628651] CPU1 attaching NULL sched-domain. [16498.628653] CPU2 attaching NULL sched-domain. [16498.632019] Switched to high resolution mode on CPU 3 [16498.640041] CPU0 attaching sched-domain: [16498.640044] domain 0: span 0-1 level MC [16498.640046] groups: 0 1 [16498.640050] domain 1: span 0-3 level CPU [16498.640053] groups: 0-1 2-3 [16498.640058] CPU1 attaching sched-domain: [16498.640060] domain 0: span 0-1 level MC [16498.640063] groups: 1 0 [16498.640067] domain 1: span 0-3 level CPU [16498.640069] groups: 0-1 2-3 [16498.640074] CPU2 attaching sched-domain: [16498.640076] domain 0: span 2-3 level MC [16498.640078] groups: 2 3 [16498.640082] domain 1: span 0-3 level CPU [16498.640084] groups: 2-3 0-1 [16498.640089] CPU3 attaching sched-domain: [16498.640091] domain 0: span 2-3 level MC [16498.640094] groups: 3 2 [16498.640097] domain 1: span 0-3 level CPU [16498.640100] groups: 2-3 0-1 [16498.640735] CPU3 is up [16498.640738] ACPI: Waking up from system sleep state S3 [16498.641284] pcieport-driver 0000:00:01.0: restoring config space at offset 0xf (was 0x1a0100, writing 0x1a010a) [16498.641293] pcieport-driver 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [16498.641324] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641351] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641376] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641409] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [16498.641424] ehci_hcd 0000:00:1a.7: PME# disabled [16498.641447] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002) [16498.641466] pcieport-driver 0000:00:1c.0: restoring config space at offset 0xf (was 0x20100, writing 0x2010b) [16498.641480] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [16498.641508] pcieport-driver 0000:00:1c.5: restoring config space at offset 0xf (was 0x20200, writing 0x2020a) [16498.641532] pcieport-driver 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [16498.641569] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641595] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641620] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [16498.641653] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [16498.641667] ehci_hcd 0000:00:1d.7: PME# disabled [16498.641674] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [16498.641795] nvidia 0000:01:00.0: restoring config space at offset 0xc (was 0xfe980000, writing 0x0) [16498.641804] nvidia 0000:01:00.0: restoring config space at offset 0x3 (was 0x8, writing 0x0) [16498.641841] ATL1E 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [16498.641861] ATL1E 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) [16498.641868] ATL1E 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [16498.641891] ohci1394 0000:04:03.0: restoring config space at offset 0xf (was 0x180c0100, writing 0x180c010b) [16498.641905] ohci1394 0000:04:03.0: restoring config space at offset 0x4 (was 0x0, writing 0xfebff000) [16498.641909] ohci1394 0000:04:03.0: restoring config space at offset 0x3 (was 0x0, writing 0x4008) [16498.641914] ohci1394 0000:04:03.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900016) [16498.642011] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [16498.642016] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [16498.642035] usb usb3: root hub lost power or was reset [16498.642050] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [16498.642054] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [16498.642071] usb usb4: root hub lost power or was reset [16498.642085] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [16498.642090] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [16498.642107] usb usb5: root hub lost power or was reset [16498.642121] ehci_hcd 0000:00:1a.7: PME# disabled [16498.642125] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [16498.642130] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [16498.642147] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [16498.642152] HDA Intel 0000:00:1b.0: setting latency timer to 64 [16498.737476] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [16498.737484] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [16498.737516] usb usb6: root hub lost power or was reset [16498.737533] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [16498.737537] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [16498.737555] usb usb7: root hub lost power or was reset [16498.737587] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [16498.737591] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [16498.737619] usb usb8: root hub lost power or was reset [16498.737646] ehci_hcd 0000:00:1d.7: PME# disabled [16498.737650] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [16498.737654] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [16498.737662] pci 0000:00:1e.0: setting latency timer to 64 [16498.737669] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [16498.737672] ata_piix 0000:00:1f.2: setting latency timer to 64 [16498.740963] ata_piix 0000:00:1f.5: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [16498.740967] ata_piix 0000:00:1f.5: setting latency timer to 64 [16499.142432] ATL1E 0000:02:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [16499.142438] ATL1E 0000:02:00.0: setting latency timer to 64 [16499.142446] ATL1E 0000:02:00.0: PME# disabled [16499.142451] ATL1E 0000:02:00.0: PME# disabled [16499.206030] ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[19] MMIO=[febff000-febff7ff] Max Packet=[2048] IR/IT contexts=[8/8] [16499.216612] serial 00:0b: activated [16499.258696] ata4: SATA link down (SStatus 0 SControl 300) [16499.404056] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [16499.412202] ata3.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out [16499.412205] ata3.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [16499.412207] ata3.00: ACPI cmd f5/00:00:00:00:00:00 filtered out [16499.428209] ata3.00: configured for UDMA/100 [16499.578708] ata2.00: SATA link down (SStatus 0 SControl 300) [16499.578716] ata2.01: SATA link down (SStatus 0 SControl 300) [16499.593029] sd 0:0:0:0: [sda] Starting disk [16504.764020] ata1.00: link is slow to respond, please be patient (ready=0) [16505.716062] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [16505.716073] ata1.01: SATA link down (SStatus 0 SControl 300) [16505.724200] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out [16505.724203] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [16505.724302] ata1.00: ACPI cmd c6/00:10:00:00:00:a0 succeeded [16505.724306] ata1.00: ACPI cmd f5/00:00:00:00:00:00 filtered out [16505.740316] ata1.00: configured for UDMA/133 [16505.756314] ata1.00: configured for UDMA/133 [16505.756318] ata1: EH complete [16505.876023] usb 7-1: reset full speed USB device using uhci_hcd and address 2 [16506.715400] snd-usb-audio 7-1:1.0: no reset_resume for driver snd-usb-audio? [16506.715403] snd-usb-audio 7-1:1.1: no reset_resume for driver snd-usb-audio? [16506.715406] snd-usb-audio 7-1:1.2: no reset_resume for driver snd-usb-audio? [16507.413977] PM: resume devices took 8.772 seconds [16507.413979] ------------[ cut here ]------------ [16507.413985] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x7c/0x80() [16507.413987] Hardware name: P5Q-PRO [16507.413988] Component: resume devices [16507.413989] Modules linked in: binfmt_misc ppdev parport_pc snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_usb_audio snd_pcm_oss coretemp snd_usb_lib snd_mixer_oss snd_hwdep sbp2 snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi lp snd_rawmidi snd_seq_midi_event parport snd_seq snd_timer iptable_filter atl1 snd_seq_device ip_tables mii nvidia(P) snd asus_atk0110 intel_agp x_tables soundcore snd_page_alloc joydev reiserfs usb_storage usbhid ohci1394 ieee1394 atl1e vesafb fbcon tileblit font bitblit softcursor [16507.414018] Pid: 4099, comm: pm-suspend Tainted: P 2.6.31-11-generic #36-Ubuntu [16507.414020] Call Trace: [16507.414025] [] warn_slowpath_common+0x78/0xb0 [16507.414028] [] warn_slowpath_fmt+0x3c/0x40 [16507.414031] [] suspend_test_finish+0x7c/0x80 [16507.414033] [] suspend_devices_and_enter+0xa9/0xe0 [16507.414036] [] enter_state+0xd8/0x110 [16507.414038] [] state_store+0x92/0x100 [16507.414042] [] kobj_attr_store+0x17/0x20 [16507.414045] [] sysfs_write_file+0xe0/0x160 [16507.414049] [] vfs_write+0xb8/0x1a0 [16507.414053] [] ? do_page_fault+0x194/0x370 [16507.414055] [] sys_write+0x4c/0x80 [16507.414059] [] system_call_fastpath+0x16/0x1b [16507.414061] ---[ end trace b5bc1fba4dd4dcdb ]--- [16507.414093] PM: Finishing wakeup. [16507.414094] Restarting tasks ... done. [16507.574622] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.574626] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.574630] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.574635] end_request: I/O error, dev sr0, sector 0 [16507.574639] Buffer I/O error on device sr0, logical block 0 [16507.574642] Buffer I/O error on device sr0, logical block 1 [16507.574646] Buffer I/O error on device sr0, logical block 2 [16507.574648] Buffer I/O error on device sr0, logical block 3 [16507.574650] Buffer I/O error on device sr0, logical block 4 [16507.574652] Buffer I/O error on device sr0, logical block 5 [16507.574655] Buffer I/O error on device sr0, logical block 6 [16507.574657] Buffer I/O error on device sr0, logical block 7 [16507.574659] Buffer I/O error on device sr0, logical block 8 [16507.574661] Buffer I/O error on device sr0, logical block 9 [16507.578120] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.578123] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.578126] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.578130] end_request: I/O error, dev sr0, sector 0 [16507.602527] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.602531] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.602535] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.602540] end_request: I/O error, dev sr0, sector 0 [16507.605149] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.605152] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.605155] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.605159] end_request: I/O error, dev sr0, sector 0 [16507.657347] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.657353] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.657357] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.657362] end_request: I/O error, dev sr0, sector 0 [16507.682431] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.682436] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.682440] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.682445] end_request: I/O error, dev sr0, sector 0 [16507.685001] sr 2:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [16507.685005] sr 2:0:0:0: [sr0] Sense Key : Illegal Request [current] [16507.685008] sr 2:0:0:0: [sr0] Add. Sense: Illegal mode for this track [16507.685013] end_request: I/O error, dev sr0, sector 0 [16510.936872] ATL1E 0000:02:00.0: irq 27 for MSI/MSI-X [16510.964440] ADDRCONF(NETDEV_UP): eth0: link is not ready [16513.184839] ATL1E 0000:02:00.0: ATL1E: eth0 NIC Link is Up<1000 Mbps Full Duplex> [16513.185380] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [16523.636021] eth0: no IPv6 routers present [16536.784018] usb 5-2: new full speed USB device using uhci_hcd and address 2 [16536.904020] usb 5-2: device descriptor read/64, error -71 [16537.128018] usb 5-2: device descriptor read/64, error -71 [16537.344018] usb 5-2: new full speed USB device using uhci_hcd and address 3 [16537.464012] usb 5-2: device descriptor read/64, error -71 [16537.688015] usb 5-2: device descriptor read/64, error -71 [16537.904023] usb 5-2: new full speed USB device using uhci_hcd and address 4 [16538.312015] usb 5-2: device not accepting address 4, error -71 [16538.424019] usb 5-2: new full speed USB device using uhci_hcd and address 5 [16538.832013] usb 5-2: device not accepting address 5, error -71 [16538.832027] hub 5-0:1.0: unable to enumerate USB device on port 2 [19268.288350] PM: Syncing filesystems ... done. [19268.307734] PM: Preparing system for mem sleep [19268.307738] Freezing user space processes ... (elapsed 0.00 seconds) done. [19268.308726] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [19268.308773] PM: Entering mem sleep [19268.308785] Suspending console(s) (use no_console_suspend to debug) [19268.356054] sd 0:0:0:0: [sda] Synchronizing SCSI cache [19268.673568] sd 0:0:0:0: [sda] Stopping disk [19269.168254] ACPI handle has no context! [19269.168593] serial 00:0b: disabled [19269.172642] ACPI handle has no context! [19269.188087] ACPI handle has no context! [19269.188093] ATL1E 0000:02:00.0: PME# disabled [19269.188101] ATL1E 0000:02:00.0: PCI INT A disabled [19269.188108] ACPI handle has no context! [19269.259270] ata_piix 0000:00:1f.5: PCI INT B disabled [19269.272105] ata_piix 0000:00:1f.2: PCI INT B disabled [19269.288038] ehci_hcd 0000:00:1d.7: PCI INT A disabled [19269.288046] uhci_hcd 0000:00:1d.2: PCI INT C disabled [19269.288053] uhci_hcd 0000:00:1d.1: PCI INT B disabled [19269.288059] uhci_hcd 0000:00:1d.0: PCI INT A disabled [19269.392087] HDA Intel 0000:00:1b.0: PCI INT A disabled [19269.392126] ACPI handle has no context! [19269.408034] ehci_hcd 0000:00:1a.7: PCI INT C disabled [19269.408041] uhci_hcd 0000:00:1a.2: PCI INT C disabled [19269.408047] uhci_hcd 0000:00:1a.1: PCI INT B disabled [19269.408054] uhci_hcd 0000:00:1a.0: PCI INT A disabled [19269.408116] PM: suspend devices took 1.100 seconds [19269.408310] ehci_hcd 0000:00:1d.7: PME# disabled [19269.424217] ehci_hcd 0000:00:1a.7: PME# disabled [19269.440656] ACPI: Preparing to enter system sleep state S3 [19269.441281] Disabling non-boot CPUs ... [19269.443442] CPU 1 is now offline [19269.443782] CPU0 attaching NULL sched-domain. [19269.443786] CPU1 attaching NULL sched-domain. [19269.443787] CPU2 attaching NULL sched-domain. [19269.443790] CPU3 attaching NULL sched-domain. [19269.452043] CPU0 attaching sched-domain: [19269.452047] domain 0: span 0,2-3 level CPU [19269.452050] groups: 0 2-3 [19269.452056] CPU2 attaching sched-domain: [19269.452058] domain 0: span 2-3 level MC [19269.452060] groups: 2 3 [19269.452065] domain 1: span 0,2-3 level CPU [19269.452067] groups: 2-3 0 [19269.452072] CPU3 attaching sched-domain: [19269.452074] domain 0: span 2-3 level MC [19269.452076] groups: 3 2 [19269.452080] domain 1: span 0,2-3 level CPU [19269.452083] groups: 2-3 0 [19269.452544] CPU1 is down [19269.454687] CPU 2 is now offline [19269.454896] CPU0 attaching NULL sched-domain. [19269.454898] CPU2 attaching NULL sched-domain. [19269.454900] CPU3 attaching NULL sched-domain. [19269.464051] CPU0 attaching sched-domain: [19269.464054] domain 0: span 0,3 level CPU [19269.464057] groups: 0 3 [19269.464062] CPU3 attaching sched-domain: [19269.464064] domain 0: span 0,3 level CPU [19269.464067] groups: 3 0 [19269.464339] CPU2 is down [19269.568018] CPU 3 is now offline [19269.568021] SMP alternatives: switching to UP code [19269.573537] CPU0 attaching NULL sched-domain. [19269.573539] CPU3 attaching NULL sched-domain. [19269.573545] CPU0 attaching NULL sched-domain. [19269.573662] CPU3 is down [19269.573668] Back to C! [19269.573668] Enabling non-boot CPUs ... [19269.573668] SMP alternatives: switching to SMP code [19269.579085] Booting processor 1 APIC 0x1 ip 0x6000 [19269.443592] Initializing CPU#1 [19269.443592] Calibrating delay using timer specific routine.. 4799.31 BogoMIPS (lpj=9598628) [19269.443592] CPU: L1 I cache: 32K, L1 D cache: 32K [19269.443592] CPU: L2 cache: 4096K [19269.443592] CPU 1/0x1 -> Node 0 [19269.443592] CPU: Physical Processor ID: 0 [19269.443592] CPU: Processor Core ID: 1 [19269.668552] CPU1: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [19269.668559] checking TSC synchronization [CPU#0 -> CPU#1]: passed. [19269.688640] CPU0 attaching NULL sched-domain. [19269.692016] Switched to high resolution mode on CPU 1 [19269.704041] CPU0 attaching sched-domain: [19269.704045] domain 0: span 0-1 level MC [19269.704048] groups: 0 1 [19269.704053] CPU1 attaching sched-domain: [19269.704056] domain 0: span 0-1 level MC [19269.704058] groups: 1 0 [19269.704532] CPU1 is up [19269.704783] Booting processor 2 APIC 0x2 ip 0x6000 [19269.454774] Initializing CPU#2 [19269.454774] Calibrating delay using timer specific routine.. 4799.38 BogoMIPS (lpj=9598760) [19269.454774] CPU: L1 I cache: 32K, L1 D cache: 32K [19269.454774] CPU: L2 cache: 4096K [19269.454774] CPU 2/0x2 -> Node 0 [19269.454774] CPU: Physical Processor ID: 0 [19269.454774] CPU: Processor Core ID: 2 [19269.792557] CPU2: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [19269.792562] checking TSC synchronization [CPU#0 -> CPU#2]: passed. [19269.812591] CPU0 attaching NULL sched-domain. [19269.812594] CPU1 attaching NULL sched-domain. [19269.816020] Switched to high resolution mode on CPU 2 [19269.828042] CPU0 attaching sched-domain: [19269.828045] domain 0: span 0-1 level MC [19269.828047] groups: 0 1 [19269.828052] domain 1: span 0-2 level CPU [19269.828054] groups: 0-1 2 [19269.828060] CPU1 attaching sched-domain: [19269.828062] domain 0: span 0-1 level MC [19269.828064] groups: 1 0 [19269.828068] domain 1: span 0-2 level CPU [19269.828071] groups: 0-1 2 [19269.828075] CPU2 attaching sched-domain: [19269.828077] domain 0: span 0-2 level CPU [19269.828080] groups: 2 0-1 [19269.828588] CPU2 is up [19269.828916] Booting processor 3 APIC 0x3 ip 0x6000 [19269.573431] Initializing CPU#3 [19269.573431] Calibrating delay using timer specific routine.. 4799.38 BogoMIPS (lpj=9598760) [19269.573431] CPU: L1 I cache: 32K, L1 D cache: 32K [19269.573431] CPU: L2 cache: 4096K [19269.573431] CPU 3/0x3 -> Node 0 [19269.573431] CPU: Physical Processor ID: 0 [19269.573431] CPU: Processor Core ID: 3 [19269.916588] CPU3: Intel(R) Core(TM)2 Quad CPU Q6600 @ 2.40GHz stepping 0b [19269.916594] checking TSC synchronization [CPU#0 -> CPU#3]: passed. [19269.936631] CPU0 attaching NULL sched-domain. [19269.936633] CPU1 attaching NULL sched-domain. [19269.936636] CPU2 attaching NULL sched-domain. [19269.940019] Switched to high resolution mode on CPU 3 [19269.948044] CPU0 attaching sched-domain: [19269.948046] domain 0: span 0-1 level MC [19269.948049] groups: 0 1 [19269.948053] domain 1: span 0-3 level CPU [19269.948056] groups: 0-1 2-3 [19269.948061] CPU1 attaching sched-domain: [19269.948063] domain 0: span 0-1 level MC [19269.948066] groups: 1 0 [19269.948069] domain 1: span 0-3 level CPU [19269.948072] groups: 0-1 2-3 [19269.948077] CPU2 attaching sched-domain: [19269.948079] domain 0: span 2-3 level MC [19269.948081] groups: 2 3 [19269.948085] domain 1: span 0-3 level CPU [19269.948087] groups: 2-3 0-1 [19269.948092] CPU3 attaching sched-domain: [19269.948094] domain 0: span 2-3 level MC [19269.948096] groups: 3 2 [19269.948100] domain 1: span 0-3 level CPU [19269.948102] groups: 2-3 0-1 [19269.948731] CPU3 is up [19269.948735] ACPI: Waking up from system sleep state S3 [19269.949284] pcieport-driver 0000:00:01.0: restoring config space at offset 0xf (was 0x1a0100, writing 0x1a010a) [19269.949293] pcieport-driver 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [19269.949324] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949351] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949376] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949409] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [19269.949424] ehci_hcd 0000:00:1a.7: PME# disabled [19269.949447] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002) [19269.949467] pcieport-driver 0000:00:1c.0: restoring config space at offset 0xf (was 0x20100, writing 0x2010b) [19269.949481] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [19269.949509] pcieport-driver 0000:00:1c.5: restoring config space at offset 0xf (was 0x20200, writing 0x2020a) [19269.949532] pcieport-driver 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [19269.949569] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949595] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949620] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [19269.949653] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [19269.949667] ehci_hcd 0000:00:1d.7: PME# disabled [19269.949674] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [19269.949794] nvidia 0000:01:00.0: restoring config space at offset 0xc (was 0xfe980000, writing 0x0) [19269.949803] nvidia 0000:01:00.0: restoring config space at offset 0x3 (was 0x8, writing 0x0) [19269.949842] ATL1E 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [19269.949862] ATL1E 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) [19269.949868] ATL1E 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [19269.949891] ohci1394 0000:04:03.0: restoring config space at offset 0xf (was 0x180c0100, writing 0x180c010b) [19269.949905] ohci1394 0000:04:03.0: restoring config space at offset 0x4 (was 0x0, writing 0xfebff000) [19269.949909] ohci1394 0000:04:03.0: restoring config space at offset 0x3 (was 0x0, writing 0x4008) [19269.949914] ohci1394 0000:04:03.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900016) [19269.950011] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [19269.950016] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [19269.950035] usb usb3: root hub lost power or was reset [19269.950050] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [19269.950054] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [19269.950071] usb usb4: root hub lost power or was reset [19269.950085] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [19269.950090] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [19269.950107] usb usb5: root hub lost power or was reset [19269.950142] ehci_hcd 0000:00:1a.7: PME# disabled [19269.950146] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [19269.950151] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [19269.950166] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [19269.950170] HDA Intel 0000:00:1b.0: setting latency timer to 64 [19270.045493] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [19270.045503] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [19270.045530] usb usb6: root hub lost power or was reset [19270.045547] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [19270.045552] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [19270.045574] usb usb7: root hub lost power or was reset [19270.045598] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [19270.045602] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [19270.045630] usb usb8: root hub lost power or was reset [19270.045657] ehci_hcd 0000:00:1d.7: PME# disabled [19270.045660] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [19270.045665] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [19270.045682] pci 0000:00:1e.0: setting latency timer to 64 [19270.045689] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [19270.045692] ata_piix 0000:00:1f.2: setting latency timer to 64 [19270.049008] ata_piix 0000:00:1f.5: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [19270.049011] ata_piix 0000:00:1f.5: setting latency timer to 64 [19270.450030] ATL1E 0000:02:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [19270.450036] ATL1E 0000:02:00.0: setting latency timer to 64 [19270.450045] ATL1E 0000:02:00.0: PME# disabled [19270.450049] ATL1E 0000:02:00.0: PME# disabled [19270.514048] ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[19] MMIO=[febff000-febff7ff] Max Packet=[2048] IR/IT contexts=[8/8] [19270.524614] serial 00:0b: activated [19270.566706] ata4: SATA link down (SStatus 0 SControl 300) [19270.712061] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [19270.720213] ata3.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out [19270.720215] ata3.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [19270.720218] ata3.00: ACPI cmd f5/00:00:00:00:00:00 filtered out [19270.736220] ata3.00: configured for UDMA/100 [19270.886668] ata2.00: SATA link down (SStatus 0 SControl 300) [19270.886679] ata2.01: SATA link down (SStatus 0 SControl 300) [19270.977279] sd 0:0:0:0: [sda] Starting disk [19276.080168] ata1.00: link is slow to respond, please be patient (ready=0) [19277.032204] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [19277.032213] ata1.01: SATA link down (SStatus 0 SControl 300) [19277.040203] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out [19277.040206] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [19277.040310] ata1.00: ACPI cmd c6/00:10:00:00:00:a0 succeeded [19277.040314] ata1.00: ACPI cmd f5/00:00:00:00:00:00 filtered out [19277.056316] ata1.00: configured for UDMA/133 [19277.072315] ata1.00: configured for UDMA/133 [19277.072318] ata1: EH complete [19277.188028] usb 7-1: reset full speed USB device using uhci_hcd and address 2 [19278.027388] snd-usb-audio 7-1:1.0: no reset_resume for driver snd-usb-audio? [19278.027391] snd-usb-audio 7-1:1.1: no reset_resume for driver snd-usb-audio? [19278.027394] snd-usb-audio 7-1:1.2: no reset_resume for driver snd-usb-audio? [19278.677954] PM: resume devices took 8.728 seconds [19278.677955] ------------[ cut here ]------------ [19278.677961] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x7c/0x80() [19278.677963] Hardware name: P5Q-PRO [19278.677965] Component: resume devices [19278.677966] Modules linked in: binfmt_misc ppdev parport_pc snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_usb_audio snd_pcm_oss coretemp snd_usb_lib snd_mixer_oss snd_hwdep sbp2 snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi lp snd_rawmidi snd_seq_midi_event parport snd_seq snd_timer iptable_filter atl1 snd_seq_device ip_tables mii nvidia(P) snd asus_atk0110 intel_agp x_tables soundcore snd_page_alloc joydev reiserfs usb_storage usbhid ohci1394 ieee1394 atl1e vesafb fbcon tileblit font bitblit softcursor [19278.677995] Pid: 4792, comm: pm-suspend Tainted: P W 2.6.31-11-generic #36-Ubuntu [19278.677997] Call Trace: [19278.678001] [] warn_slowpath_common+0x78/0xb0 [19278.678004] [] warn_slowpath_fmt+0x3c/0x40 [19278.678007] [] suspend_test_finish+0x7c/0x80 [19278.678010] [] suspend_devices_and_enter+0xa9/0xe0 [19278.678012] [] enter_state+0xd8/0x110 [19278.678014] [] state_store+0x92/0x100 [19278.678018] [] kobj_attr_store+0x17/0x20 [19278.678022] [] sysfs_write_file+0xe0/0x160 [19278.678025] [] vfs_write+0xb8/0x1a0 [19278.678029] [] ? do_page_fault+0x194/0x370 [19278.678031] [] sys_write+0x4c/0x80 [19278.678035] [] system_call_fastpath+0x16/0x1b [19278.678037] ---[ end trace b5bc1fba4dd4dcdc ]--- [19278.678068] PM: Finishing wakeup. [19278.678070] Restarting tasks ... done. [19281.246572] ATL1E 0000:02:00.0: irq 27 for MSI/MSI-X [19281.272436] ADDRCONF(NETDEV_UP): eth0: link is not ready [19283.508575] ATL1E 0000:02:00.0: ATL1E: eth0 NIC Link is Up<1000 Mbps Full Duplex> [19283.508948] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [19294.116507] eth0: no IPv6 routers present