Bug 51189

Summary: TTM errors when suspending (call trace)
Product: DRI Reporter: Harald Judt <h.judt>
Component: DRM/RadeonAssignee: Default DRI bug account <dri-devel>
Status: RESOLVED FIXED QA Contact:
Severity: normal    
Priority: medium    
Version: XOrg git   
Hardware: x86-64 (AMD64)   
OS: Linux (All)   
Whiteboard:
i915 platform: i915 features:

Description Harald Judt 2012-06-17 23:28:39 UTC 
Linux 3.4.0+ #53 SMP PREEMPT Mon Jun 11 15:16:31 CEST 2012 x86_64 Intel(R) Core(TM) i7-2600K CPU @ 3.40GHz GenuineIntel GNU/Linux

Recently I found these messages in dmesg when I tried to suspend the machine:

Freezing user space processes ... (elapsed 0.01 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Suspending console(s) (use no_console_suspend to debug)
sd 1:0:0:0: [sdb] Synchronizing SCSI cache
sd 0:0:0:0: [sda] Synchronizing SCSI cache
sd 0:0:0:0: [sda] Stopping disk
sd 1:0:0:0: [sdb] Stopping disk
serial 00:09: disabled
serial 00:09: wake-up capability disabled by ACPI
i8042 kbd 00:08: wake-up capability enabled by ACPI
ACPI handle has no context!
ACPI handle has no context!
ACPI handle has no context!
kworker/u:20: page allocation failure: order:0, mode:0x28010
Pid: 9562, comm: kworker/u:20 Tainted: G           O 3.4.0+ #53
Call Trace:
 [<ffffffff8108f86f>] warn_alloc_failed+0x110/0x125
 [<ffffffff810998bf>] ? try_to_free_pages+0x68/0x6a
 [<ffffffff81091fd2>] __alloc_pages_nodemask+0x6c1/0x6f7
 [<ffffffff81006336>] dma_generic_alloc_coherent+0xaf/0x119
 [<ffffffff8101cd7f>] x86_swiotlb_alloc_coherent+0x1c/0x3d
 [<ffffffff812b0fae>] ttm_dma_populate+0x487/0x74f
 [<ffffffff812d662a>] radeon_ttm_tt_populate+0x3d/0x18d
 [<ffffffff812a9848>] ttm_tt_bind+0x2c/0x4f
 [<ffffffff812ab15d>] ttm_bo_handle_move_mem+0x132/0x33e
 [<ffffffff812abcd3>] ? ttm_bo_mem_space+0xfb/0x2c9
 [<ffffffff812d5c00>] ? radeon_sync_obj_ref+0xa/0xb
 [<ffffffff812c4810>] ? cail_reg_write+0x16/0x18
 [<ffffffff812ab616>] ttm_bo_evict+0x2ad/0x2f6
 [<ffffffff812aef5b>] ? ttm_eu_list_ref_sub+0x24/0x38
 [<ffffffff812ab7ed>] ttm_mem_evict_first+0x18e/0x1c9
 [<ffffffff812ab88a>] ttm_bo_force_list_clean+0x62/0xa4
 [<ffffffff812ab916>] ttm_bo_evict_mm+0x4a/0x4c
 [<ffffffff812d7331>] radeon_bo_evict_vram+0x15/0x17
 [<ffffffff812c5a0f>] radeon_suspend_kms+0x10d/0x1c8
 [<ffffffff812b14e2>] radeon_pci_suspend+0x22/0x24
 [<ffffffff81233074>] pci_legacy_suspend+0x34/0xb8
 [<ffffffff81233774>] pci_pm_suspend+0x45/0xfa
 [<ffffffff8123372f>] ? pci_pm_resume+0x99/0x99
 [<ffffffff8132cfba>] dpm_run_callback.isra.5+0x2a/0x58
 [<ffffffff8132d8bd>] __device_suspend+0x145/0x1c6
 [<ffffffff810419e9>] ? async_schedule+0x12/0x12
 [<ffffffff8132db7b>] async_suspend+0x1a/0x85
 [<ffffffff81041a86>] async_run_entry_fn+0x9d/0x14f
 [<ffffffff81038b67>] process_one_work+0x1b9/0x2e8
 [<ffffffff810370da>] ? need_to_create_worker+0xd/0x21
 [<ffffffff810390f2>] worker_thread+0x15b/0x21c
 [<ffffffff81038f97>] ? manage_workers.isra.28+0x16a/0x16a
 [<ffffffff8103ca10>] kthread+0x86/0x8e
 [<ffffffff81044222>] ? schedule_tail+0x50/0xb1
 [<ffffffff81414014>] kernel_thread_helper+0x4/0x10
 [<ffffffff8103c98a>] ? kthread_freezable_should_stop+0x4d/0x4d
 [<ffffffff81414010>] ? gs_change+0xb/0xb
Mem-Info:
Node 0 DMA per-cpu:
CPU    0: hi:    0, btch:   1 usd:   0
CPU    1: hi:    0, btch:   1 usd:   0
CPU    2: hi:    0, btch:   1 usd:   0
CPU    3: hi:    0, btch:   1 usd:   0
CPU    4: hi:    0, btch:   1 usd:   0
CPU    5: hi:    0, btch:   1 usd:   0
CPU    6: hi:    0, btch:   1 usd:   0
CPU    7: hi:    0, btch:   1 usd:   0
Node 0 DMA32 per-cpu:
CPU    0: hi:  186, btch:  31 usd: 172
CPU    1: hi:  186, btch:  31 usd:  30
CPU    2: hi:  186, btch:  31 usd: 179
CPU    3: hi:  186, btch:  31 usd: 176
CPU    4: hi:  186, btch:  31 usd: 167
CPU    5: hi:  186, btch:  31 usd: 158
CPU    6: hi:  186, btch:  31 usd:   8
CPU    7: hi:  186, btch:  31 usd:  31
Node 0 Normal per-cpu:
CPU    0: hi:  186, btch:  31 usd:  75
CPU    1: hi:  186, btch:  31 usd: 117
CPU    2: hi:  186, btch:  31 usd:  67
CPU    3: hi:  186, btch:  31 usd: 146
CPU    4: hi:  186, btch:  31 usd: 118
CPU    5: hi:  186, btch:  31 usd:  82
CPU    6: hi:  186, btch:  31 usd: 153
CPU    7: hi:  186, btch:  31 usd: 155
active_anon:113306 inactive_anon:132606 isolated_anon:0
 active_file:365473 inactive_file:3041451 isolated_file:0
 unevictable:184211 dirty:16 writeback:2 unstable:0
 free:33437 slab_reclaimable:111913 slab_unreclaimable:9741
 mapped:198967 shmem:3493 pagetables:9976 bounce:0
Node 0 DMA free:14500kB min:64kB low:80kB high:96kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15648kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
lowmem_reserve[]: 0 2978 16075 16075
Node 0 DMA32 free:64580kB min:12512kB low:15640kB high:18768kB active_anon:49216kB inactive_anon:72588kB active_file:45872kB inactive_file:2672020kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:3050368kB mlocked:0kB dirty:0kB writeback:0kB mapped:52kB shmem:0kB slab_reclaimable:81412kB slab_unreclaimable:1636kB kernel_stack:120kB pagetables:3736kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 13096 13096
Node 0 Normal free:54668kB min:55004kB low:68752kB high:82504kB active_anon:404008kB inactive_anon:457836kB active_file:1416020kB inactive_file:9493784kB unevictable:736844kB isolated(anon):0kB isolated(file):0kB present:13410432kB mlocked:737408kB dirty:64kB writeback:8kB mapped:795816kB shmem:13972kB slab_reclaimable:366240kB slab_unreclaimable:37312kB kernel_stack:2984kB pagetables:36168kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
Node 0 DMA: 1*4kB 0*8kB 0*16kB 1*32kB 0*64kB 1*128kB 0*256kB 0*512kB 0*1024kB 1*2048kB 3*4096kB = 14500kB
Node 0 DMA32: 217*4kB 122*8kB 85*16kB 52*32kB 53*64kB 38*128kB 35*256kB 17*512kB 17*1024kB 8*2048kB 0*4096kB = 64580kB
Node 0 Normal: 586*4kB 196*8kB 133*16kB 175*32kB 176*64kB 5*128kB 2*256kB 8*512kB 6*1024kB 6*2048kB 2*4096kB = 54776kB
3594629 total pagecache pages
0 pages in swap cache
Swap cache stats: add 0, delete 0, find 0/0
Free swap  = 4194300kB
Total swap = 4194300kB
4192240 pages RAM
87569 pages reserved
3071034 pages shared
1215016 pages non-shared
kworker/u:20: page allocation failure: order:0, mode:0x20010

There are many of these. Further below:
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
SLUB: Unable to allocate memory on node -1 (gfp=0xd0)
  cache: kmalloc-64, object size: 64, buffer size: 64, default order: 0, min order: 0
  node 0: slabs: 1245, objs: 79680, free: 0
[TTM] radeon 0000:01:00.0: Unable to get page 2
[TTM] radeon 0000:01:00.0: Failed to set 2 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-12)!
SLUB: Unable to allocate memory on node -1 (gfp=0xd0)
  cache: kmalloc-64, object size: 64, buffer size: 64, default order: 0, min order: 0
  node 0: slabs: 1245, objs: 79680, free: 0
[TTM] radeon 0000:01:00.0: Unable to get page 1
[TTM] radeon 0000:01:00.0: Failed to set 1 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-12)!
[TTM] Buffer eviction failed
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] radeon 0000:01:00.0: Failed to set 4 pages to wc!
[TTM] radeon 0000:01:00.0: Failed to fill wc pool (r:-22)!
[TTM] Failed allocating page table
[TTM] Buffer eviction failed
PM: suspend of devices complete after 719.845 msecs
PM: late suspend of devices complete after 0.096 msecs
pcieport 0000:00:1c.7: wake-up capability enabled by ACPI
pcieport 0000:00:1c.6: wake-up capability enabled by ACPI
pcieport 0000:00:1c.5: wake-up capability enabled by ACPI
ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI
ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI
PM: noirq suspend of devices complete after 54.969 msecs
ACPI: Preparing to enter system sleep state S3
PM: Saving platform NVS memory
Disabling non-boot CPUs ...
_cpu_down: attempt to take down CPU 1 failed
Error taking CPU1 down: -12
Non-boot CPUs are not disabled
ACPI: Waking up from system sleep state S3
ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI
ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI
pcieport 0000:00:1c.5: wake-up capability disabled by ACPI
pcieport 0000:00:1c.6: wake-up capability disabled by ACPI
PM: noirq resume of devices complete after 121.294 msecs
PM: early resume of devices complete after 0.024 msecs
ehci_hcd 0000:00:1a.0: setting latency timer to 64
ahci 0000:00:1f.2: setting latency timer to 64
ehci_hcd 0000:00:1d.0: setting latency timer to 64
pcieport 0000:00:1c.7: wake-up capability disabled by ACPI
usb usb1: root hub lost power or was reset
usb usb2: root hub lost power or was reset
usb usb3: root hub lost power or was reset
usb usb4: root hub lost power or was reset
snd_hda_intel 0000:00:1b.0: irq 58 for MSI/MSI-X
i8042 kbd 00:08: wake-up capability disabled by ACPI
snd_hda_intel 0000:01:00.1: irq 59 for MSI/MSI-X
xhci_hcd 0000:05:00.0: irq 60 for MSI/MSI-X
xhci_hcd 0000:04:00.0: irq 61 for MSI/MSI-X
serial 00:09: activated
r8169 0000:0c:00.0: eth0: link down
[drm] PCIE GART of 512M enabled (table at 0x0000000000141000).
radeon 0000:01:00.0: WB enabled
[drm] fence driver on ring 0 use gpu addr 0x80000c00 and cpu addr 0xffff880427833c00
[drm] fence driver on ring 1 use gpu addr 0x80000c04 and cpu addr 0xffff880427833c04
[drm] fence driver on ring 2 use gpu addr 0x80000c08 and cpu addr 0xffff880427833c08

Suspend failed once but worked on the second try, and everything worked fine after resume. Anyway, I thought I'd post that here, maybe it is of some help to someone.
Comment 1 Michel Dänzer 2016-01-29 07:20:01 UTC 
Is this still happening with current kernels?
Comment 2 Harald Judt 2016-01-29 07:23:25 UTC 
No. I'm closing this as my hardware configuration has changed.

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.