Attachment 64586 Details for Bug 52429 – after doing S3 with X and glxgears dmesg info

after doing S3 with X and glxgears dmesg info

20120724S3withglxgears.log (text/plain), 7.96 KB, created by Guang Yang on 2012-07-24 07:05:47 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Guang Yang

Created: 2012-07-24 07:05:47 UTC

Size: 7.96 KB

patch

obsolete

>[ 1039.987860] PM: Syncing filesystems ... done.
>[ 1039.999142] PM: Preparing system for mem sleep
>[ 1040.101523] Freezing user space processes ... (elapsed 0.01 seconds) done.
>[ 1040.112062] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
>[ 1040.123046] PM: Entering mem sleep
>[ 1040.123188] Suspending console(s) (use no_console_suspend to debug)
>[ 1040.123441] sd 2:0:0:0: [sda] Synchronizing SCSI cache
>[ 1040.123664] ACPI handle has no context!
>[ 1040.123778] ACPI handle has no context!
>[ 1040.148187] sd 2:0:0:0: [sda] Stopping disk
>[ 1040.294517] e1000e 0000:00:19.0: wake-up capability enabled by ACPI
>[ 1040.897162] PM: suspend of devices complete after 774.745 msecs
>[ 1040.897309] PM: late suspend of devices complete after 0.144 msecs
>[ 1040.897816] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI
>[ 1040.908443] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI
>[ 1040.919278] PM: noirq suspend of devices complete after 21.989 msecs
>[ 1040.919972] ACPI: Preparing to enter system sleep state S3
>[ 1040.920281] PM: Saving platform NVS memory
>[ 1040.935868] Disabling non-boot CPUs ...
>[ 1040.937253] CPU 1 is now offline
>[ 1040.939165] CPU 2 is now offline
>[ 1040.940874] CPU 3 is now offline
>[ 1040.942388] CPU 4 is now offline
>[ 1040.944119] CPU 5 is now offline
>[ 1040.945571] CPU 6 is now offline
>[ 1041.047974] CPU 7 is now offline
>[ 1041.048287] Extended CMOS year: 2000
>[ 1041.049821] ACPI: Low-level resume complete
>[ 1041.049861] PM: Restoring platform NVS memory
>[ 1041.050456] Extended CMOS year: 2000
>[ 1041.050488] Enabling non-boot CPUs ...
>[ 1041.050551] Booting Node 0 Processor 1 APIC 0x1
>[ 1041.064794] CPU1 is up
>[ 1041.064859] Booting Node 0 Processor 2 APIC 0x2
>[ 1041.078922] CPU2 is up
>[ 1041.078987] Booting Node 0 Processor 3 APIC 0x3
>[ 1041.093059] CPU3 is up
>[ 1041.093118] Booting Node 0 Processor 4 APIC 0x4
>[ 1041.107179] CPU4 is up
>[ 1041.107244] Booting Node 0 Processor 5 APIC 0x5
>[ 1041.121373] CPU5 is up
>[ 1041.121433] Booting Node 0 Processor 6 APIC 0x6
>[ 1041.135531] CPU6 is up
>[ 1041.135589] Booting Node 0 Processor 7 APIC 0x7
>[ 1041.149719] CPU7 is up
>[ 1041.158824] ACPI: Waking up from system sleep state S3
>[ 1041.159362] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI
>[ 1041.159640] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI
>[ 1041.160164] PM: noirq resume of devices complete after 1.082 msecs
>[ 1041.160233] PM: early resume of devices complete after 0.046 msecs
>[ 1041.160252] i915 0000:00:02.0: setting latency timer to 64
>[ 1041.160259] ehci_hcd 0000:00:1a.0: setting latency timer to 64
>[ 1041.160273] ehci_hcd 0000:00:1d.0: setting latency timer to 64
>[ 1041.160275] e1000e 0000:00:19.0: wake-up capability disabled by ACPI
>[ 1041.160277] pci 0000:00:1e.0: setting latency timer to 64
>[ 1041.160288] pci 0000:00:14.0: CONFIG_USB_XHCI_HCD is turned off, defaulting to EHCI.
>[ 1041.160290] pci 0000:00:14.0: USB 3.0 devices will work at USB 2.0 speeds.
>[ 1041.160296] ahci 0000:00:1f.2: setting latency timer to 64
>[ 1041.160410] snd_hda_intel 0000:00:1b.0: irq 42 for MSI/MSI-X
>[ 1041.160449] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X
>[ 1041.218091] [drm] Enabling RC6 states: RC6 on, RC6p on, RC6pp off
>[ 1041.711454] firewire_core 0000:04:00.0: rediscovered device fw0
>[ 1042.922074] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx
>[ 1042.922077] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO
>[ 1046.508192] ata3: link is slow to respond, please be patient (ready=0)
>[ 1047.781802] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
>[ 1048.315373] ata3.00: configured for UDMA/100
>[ 1048.315516] sd 2:0:0:0: [sda] Starting disk
>[ 1048.333277] PM: resume of devices complete after 7180.922 msecs
>[ 1048.333386] PM: Finishing wakeup.
>[ 1048.333387] Restarting tasks ... done.
>[ 1048.334203] video LNXVIDEO:00: Restoring backlight state
>[ 1049.967346] [drm:i915_hangcheck_ring_idle] *ERROR* Hangcheck timer elapsed... render ring idle
>[ 1051.469700] [drm:i915_hangcheck_ring_idle] *ERROR* Hangcheck timer elapsed... render ring idle
>[ 1052.972049] [drm:i915_hangcheck_ring_idle] *ERROR* Hangcheck timer elapsed... render ring idle
>[ 1052.972072] [drm:i915_hangcheck_hung] *ERROR* Hangcheck timer elapsed... GPU hung
>[ 1052.972074] [drm] capturing error event; look for more information in /debug/dri/0/i915_error_state
>[ 1052.976179] ------------[ cut here ]------------
>[ 1052.976232] kernel BUG at drivers/gpu/drm/i915/i915_gem.c:1467!
>[ 1052.976277] invalid opcode: 0000 [#1] SMP 
>[ 1052.976314] CPU 4 
>[ 1052.976331] Modules linked in: sunrpc cpufreq_ondemand acpi_cpufreq freq_table mperf dm_mirror dm_region_hash dm_log snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_seq snd_seq_device snd_pcm snd_timer snd coretemp hwmon kvm_intel kvm sg soundcore lpc_ich mfd_core i2c_i801 pcspkr microcode shpchp e1000e snd_page_alloc ipv6 autofs4 ext3 jbd mbcache sd_mod firewire_ohci firewire_core crc_itu_t ehci_hcd i915 drm_kms_helper drm i2c_algo_bit button i2c_core video dm_mod [last unloaded: scsi_wait_scan]
>[ 1052.976784] 
>[ 1052.976789] Pid: 4881, comm: kworker/u:10 Not tainted 3.5.0_drm-intel-testing_20120723+ #23 Intel Corporation 2012 Client Platform/LosLunas 2 CRB
>[ 1052.976890] RIP: 0010:[<ffffffffa0099cc0>]  [<ffffffffa0099cc0>] i915_gem_object_move_to_inactive+0x44/0xcd [i915]
>[ 1052.976983] RSP: 0018:ffff880146935d10  EFLAGS: 00010202
>[ 1052.977023] RAX: 0000000000000000 RBX: ffff880146237c00 RCX: ffff880146237cc0
>[ 1052.977108] RDX: 0000000000000000 RSI: ffff88014937f4c0 RDI: ffff880146237cc0
>[ 1052.977160] RBP: ffff880146935d30 R08: ffff880145646780 R09: 0000000000000378
>[ 1052.977212] R10: 0000000000000378 R11: 0000000000000378 R12: ffff880146237cc0
>[ 1052.977264] R13: ffff880145644000 R14: ffff880145e95bc0 R15: ffff880145644000
>[ 1052.977317] FS:  0000000000000000(0000) GS:ffff88014e280000(0000) knlGS:0000000000000000
>[ 1052.977375] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
>[ 1052.977418] CR2: 00007fde950290a0 CR3: 0000000146000000 CR4: 00000000001407e0
>[ 1052.977471] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
>[ 1052.977523] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
>[ 1052.977575] Process kworker/u:10 (pid: 4881, threadinfo ffff880146934000, task ffff880149350000)
>[ 1052.977638] Stack:
>[ 1052.977654]  0000000000000378 ffff8801456451f8 ffff880145645120 0000000000000000
>[ 1052.977717]  ffff880146935d90 ffffffffa009ac56 0000000000000000 ffff880145645208
>[ 1052.977779]  ffff880145e4d1c0 ffff880145f92000 ffff880146935d90 ffff880145f92000
>[ 1052.977841] Call Trace:
>[ 1052.977875]  [<ffffffffa009ac56>] i915_gem_reset+0xa6/0x115 [i915]
>[ 1052.977930]  [<ffffffffa008c106>] i915_reset+0x3d/0x140 [i915]
>[ 1052.977982]  [<ffffffffa009042b>] ? gen6_pm_rps_work+0x98/0x98 [i915]
>[ 1052.978042]  [<ffffffffa00904d7>] i915_error_work_func+0xac/0xe6 [i915]
>[ 1052.978100]  [<ffffffff81041ff0>] process_one_work+0x1da/0x33c
>[ 1052.978146]  [<ffffffff8103fcba>] ? need_to_create_worker+0xd/0x21
>[ 1052.978193]  [<ffffffff81042437>] worker_thread+0x152/0x210
>[ 1052.978237]  [<ffffffff810422e5>] ? rescuer_thread+0x169/0x169
>[ 1052.978282]  [<ffffffff8104615b>] kthread+0x86/0x8e
>[ 1052.978321]  [<ffffffff813cfa14>] kernel_thread_helper+0x4/0x10
>[ 1052.978367]  [<ffffffff810460d5>] ? kthread_freezable_should_stop+0x52/0x52
>[ 1052.978419]  [<ffffffff813cfa10>] ? gs_change+0xb/0xb
>[ 1052.978456] Code: 4c 89 e7 4c 8b a8 30 03 00 00 e8 7c 09 16 e1 4c 89 e7 49 8b b5 88 27 00 00 49 8d 95 80 27 00 00 e8 2c 0a 16 e1 f6 43 70 41 74 02 <0f> 0b f6 83 e0 00 00 00 01 75 02 0f 0b 4c 8d a3 b0 00 00 00 4c 
>[ 1052.978736] RIP  [<ffffffffa0099cc0>] i915_gem_object_move_to_inactive+0x44/0xcd [i915]
>[ 1052.978805]  RSP <ffff880146935d10>
>[ 1062.965073] [drm:i915_gem_wait_for_error] *ERROR* Timed out waiting for the gpu reset to complete
>[ 1072.955096] [drm:i915_gem_wait_for_error] *ERROR* Timed out waiting for the gpu reset to complete
>[ 1112.911184] INFO: rcu_sched detected stalls on CPUs/tasks: { 4} (detected by 3, t=60002 jiffies)
>[ 1112.911264] INFO: Stall ended before state dump start

Actions: View

Attachments on bug 52429: 64586 | 64962 | 64970 | 65260 | 65326 | 65327 | 65486 | 65487 | 65527

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.