2014-04-16 22:19:04

by poma

[permalink] [raw]
Subject: debug_dma_assert_idle - snd_hda_intel - cpu touching an active dma mapped cacheline


Sound whispers,

WARNING: CPU: 3 PID: 900 at lib/dma-debug.c:593
debug_dma_assert_idle+0x159/0x1d0()
snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped
cacheline [cln=0x03014000]
CPU: 3 PID: 900 Comm: chronyd Not tainted 3.15.0-0.rc1.git1.1.fc21.i686 #1
Call Trace:
[<c0ae256d>] dump_stack+0x48/0x60
[<c0454402>] warn_slowpath_common+0x82/0xa0
[<c0750b69>] ? debug_dma_assert_idle+0x159/0x1d0
[<c0750b69>] ? debug_dma_assert_idle+0x159/0x1d0
[<c045445e>] warn_slowpath_fmt+0x3e/0x60
[<c0750b69>] debug_dma_assert_idle+0x159/0x1d0
[<c05860b9>] ? anon_vma_prepare+0x29/0x140
[<c057a4ee>] do_wp_page+0xce/0x890
[<c0500045>] ? auditsc_get_stamp+0x45/0x70
[<c057caf2>] handle_mm_fault+0x662/0xb70
[<c0500045>] ? auditsc_get_stamp+0x45/0x70
[<c0aee507>] __do_page_fault+0x1a7/0x5d0
[<c040ace8>] ? sched_clock+0x8/0x10
[<c040ace8>] ? sched_clock+0x8/0x10
[<c04ab036>] ? lock_release_holdtime.part.28+0x96/0xf0
[<c0aee930>] ? __do_page_fault+0x5d0/0x5d0
[<c0aee94a>] do_page_fault+0x1a/0x20
[<c0aeb344>] error_code+0x6c/0x74
[<c07334b6>] ? __put_user_4+0x1a/0x24
[<c048d280>] ? schedule_tail+0x60/0xa0
[<c0af3746>] ret_from_fork+0x6/0x20
---[ end trace d31d73481e988403 ]---
Mapped at:
[<c074ec12>] debug_dma_alloc_coherent+0x22/0x70
[<f812de90>] snd_dma_alloc_pages+0x170/0x260 [snd_pcm]
[<f812dfe2>] snd_dma_alloc_pages_fallback+0x62/0x90 [snd_pcm]
[<f812e3b0>] snd_malloc_sgbuf_pages+0xf0/0x211 [snd_pcm]
[<f812df23>] snd_dma_alloc_pages+0x203/0x260 [snd_pcm]


https://bugzilla.redhat.com/show_bug.cgi?id=1087565


poma


2014-04-17 07:41:05

by Clemens Ladisch

[permalink] [raw]
Subject: Re: debug_dma_assert_idle - snd_hda_intel - cpu touching an active dma mapped cacheline

poma wrote:
> Sound whispers,

???

> WARNING: CPU: 3 PID: 900 at lib/dma-debug.c:593 debug_dma_assert_idle+0x159/0x1d0()
> snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped cacheline [cln=0x03014000]
> ...
> Mapped at:
> [<c074ec12>] debug_dma_alloc_coherent+0x22/0x70

"Coherent" means "touching DMA mappings is allowed".
Why does dma-debug complain about that?


Regards,
Clemens

2014-04-17 17:18:29

by poma

[permalink] [raw]
Subject: Re: debug_dma_assert_idle - snd_hda_intel - cpu touching an active dma mapped cacheline

On 17.04.2014 09:40, Clemens Ladisch wrote:
> poma wrote:
>> Sound whispers,
>
> ???
>
>> WARNING: CPU: 3 PID: 900 at lib/dma-debug.c:593 debug_dma_assert_idle+0x159/0x1d0()
>> snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped cacheline [cln=0x03014000]
>> ...
>> Mapped at:
>> [<c074ec12>] debug_dma_alloc_coherent+0x22/0x70
>
> "Coherent" means "touching DMA mappings is allowed".
> Why does dma-debug complain about that?
>
>
> Regards,
> Clemens
>

Thanks for comment.
Waiting for rc2 to be sure!


poma

2014-04-23 00:54:00

by poma

[permalink] [raw]
Subject: Re: debug_dma_assert_idle - snd_hda_intel - cpu touching an active dma mapped cacheline


This one comes and goes...

------------[ cut here ]------------
WARNING: CPU: 2 PID: 521 at lib/dma-debug.c:593
debug_dma_assert_idle+0x159/0x1d0()
snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped
cacheline [cln=0x03019000]
------------[ cut here ]------------
WARNING: CPU: 3 PID: 927 at lib/dma-debug.c:593
debug_dma_assert_idle+0x159/0x1d0()
snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped
cacheline [cln=0x03019000]

CPU: 3 PID: 927 Comm: firewalld Not tainted 3.15.0-0.rc2.git1.1.fc21.i686 #1

Call Trace:

[<c0ae29dd>] dump_stack+0x48/0x60

[<c0454402>] warn_slowpath_common+0x82/0xa0

[<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0

[<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0

[<c045445e>] warn_slowpath_fmt+0x3e/0x60

[<c0750e09>] debug_dma_assert_idle+0x159/0x1d0

[<c0586189>] ? anon_vma_prepare+0x29/0x140

[<c057a5be>] do_wp_page+0xce/0x890

[<c0640065>] ? ext4_releasepage+0x95/0x130

[<c057cbc2>] handle_mm_fault+0x662/0xb70

[<c0640065>] ? ext4_releasepage+0x95/0x130

[<c0aee997>] __do_page_fault+0x1a7/0x5d0

[<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0

[<c04ff83c>] ? __audit_syscall_entry+0x8c/0xe0

[<c04add5b>] ? trace_hardirqs_on+0xb/0x10

[<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0

[<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0

[<c0aeedc0>] ? __do_page_fault+0x5d0/0x5d0

[<c0aeedda>] do_page_fault+0x1a/0x20

[<c0aeb7b4>] error_code+0x6c/0x74
---[ end trace 0464944e27da06b8 ]---
Mapped at:

[<c074eeb2>] debug_dma_alloc_coherent+0x22/0x70

[<f839de90>] snd_dma_alloc_pages+0x170/0x260 [snd_pcm]

[<f839dfe2>] snd_dma_alloc_pages_fallback+0x62/0x90 [snd_pcm]

[<f839e3b0>] snd_malloc_sgbuf_pages+0xf0/0x211 [snd_pcm]

[<f839df23>] snd_dma_alloc_pages+0x203/0x260 [snd_pcm]
CPU: 2 PID: 521 Comm: firewalld Tainted: G W
3.15.0-0.rc2.git1.1.fc21.i686 #1
Call Trace:
[<c0ae29dd>] dump_stack+0x48/0x60
[<c0454402>] warn_slowpath_common+0x82/0xa0
[<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
[<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
[<c045445e>] warn_slowpath_fmt+0x3e/0x60
[<c0750e09>] debug_dma_assert_idle+0x159/0x1d0
[<c0586189>] ? anon_vma_prepare+0x29/0x140
[<c057a5be>] do_wp_page+0xce/0x890
[<c0640065>] ? ext4_releasepage+0x95/0x130
[<c057cbc2>] handle_mm_fault+0x662/0xb70
[<c0640065>] ? ext4_releasepage+0x95/0x130
[<c0aee997>] __do_page_fault+0x1a7/0x5d0
[<c04ff83c>] ? __audit_syscall_entry+0x8c/0xe0
[<c04add5b>] ? trace_hardirqs_on+0xb/0x10
[<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0
[<c0aeedc0>] ? __do_page_fault+0x5d0/0x5d0
[<c0aeedda>] do_page_fault+0x1a/0x20
[<c0aeb7b4>] error_code+0x6c/0x74
---[ end trace 0464944e27da06b9 ]---
Mapped at:
[<c074eeb2>] debug_dma_alloc_coherent+0x22/0x70
[<f839de90>] snd_dma_alloc_pages+0x170/0x260 [snd_pcm]
[<f839dfe2>] snd_dma_alloc_pages_fallback+0x62/0x90 [snd_pcm]
[<f839e3b0>] snd_malloc_sgbuf_pages+0xf0/0x211 [snd_pcm]
[<f839df23>] snd_dma_alloc_pages+0x203/0x260 [snd_pcm]


https://bugzilla.redhat.com/attachment.cgi?id=888686

dma debug: account for cachelines and read-only mappings in overlap tracking
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git/commit/lib/dma-debug.c?id=3b7a6418c7494b8bf0bf0537ddee1dedbca10f51

Are these two in some relation?


poma

2014-04-23 05:33:20

by poma

[permalink] [raw]
Subject: Re: debug_dma_assert_idle - snd_hda_intel - cpu touching an active dma mapped cacheline

On 23.04.2014 02:53, poma wrote:
>
> This one comes and goes...
>
> ------------[ cut here ]------------
> WARNING: CPU: 2 PID: 521 at lib/dma-debug.c:593
> debug_dma_assert_idle+0x159/0x1d0()
> snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped
> cacheline [cln=0x03019000]
> ------------[ cut here ]------------
> WARNING: CPU: 3 PID: 927 at lib/dma-debug.c:593
> debug_dma_assert_idle+0x159/0x1d0()
> snd_hda_intel 0000:00:07.0: DMA-API: cpu touching an active dma mapped
> cacheline [cln=0x03019000]
>
> CPU: 3 PID: 927 Comm: firewalld Not tainted 3.15.0-0.rc2.git1.1.fc21.i686 #1
>
> Call Trace:
>
> [<c0ae29dd>] dump_stack+0x48/0x60
>
> [<c0454402>] warn_slowpath_common+0x82/0xa0
>
> [<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
>
> [<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
>
> [<c045445e>] warn_slowpath_fmt+0x3e/0x60
>
> [<c0750e09>] debug_dma_assert_idle+0x159/0x1d0
>
> [<c0586189>] ? anon_vma_prepare+0x29/0x140
>
> [<c057a5be>] do_wp_page+0xce/0x890
>
> [<c0640065>] ? ext4_releasepage+0x95/0x130
>
> [<c057cbc2>] handle_mm_fault+0x662/0xb70
>
> [<c0640065>] ? ext4_releasepage+0x95/0x130
>
> [<c0aee997>] __do_page_fault+0x1a7/0x5d0
>
> [<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0
>
> [<c04ff83c>] ? __audit_syscall_entry+0x8c/0xe0
>
> [<c04add5b>] ? trace_hardirqs_on+0xb/0x10
>
> [<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0
>
> [<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0
>
> [<c0aeedc0>] ? __do_page_fault+0x5d0/0x5d0
>
> [<c0aeedda>] do_page_fault+0x1a/0x20
>
> [<c0aeb7b4>] error_code+0x6c/0x74
> ---[ end trace 0464944e27da06b8 ]---
> Mapped at:
>
> [<c074eeb2>] debug_dma_alloc_coherent+0x22/0x70
>
> [<f839de90>] snd_dma_alloc_pages+0x170/0x260 [snd_pcm]
>
> [<f839dfe2>] snd_dma_alloc_pages_fallback+0x62/0x90 [snd_pcm]
>
> [<f839e3b0>] snd_malloc_sgbuf_pages+0xf0/0x211 [snd_pcm]
>
> [<f839df23>] snd_dma_alloc_pages+0x203/0x260 [snd_pcm]
> CPU: 2 PID: 521 Comm: firewalld Tainted: G W
> 3.15.0-0.rc2.git1.1.fc21.i686 #1
> Call Trace:
> [<c0ae29dd>] dump_stack+0x48/0x60
> [<c0454402>] warn_slowpath_common+0x82/0xa0
> [<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
> [<c0750e09>] ? debug_dma_assert_idle+0x159/0x1d0
> [<c045445e>] warn_slowpath_fmt+0x3e/0x60
> [<c0750e09>] debug_dma_assert_idle+0x159/0x1d0
> [<c0586189>] ? anon_vma_prepare+0x29/0x140
> [<c057a5be>] do_wp_page+0xce/0x890
> [<c0640065>] ? ext4_releasepage+0x95/0x130
> [<c057cbc2>] handle_mm_fault+0x662/0xb70
> [<c0640065>] ? ext4_releasepage+0x95/0x130
> [<c0aee997>] __do_page_fault+0x1a7/0x5d0
> [<c04ff83c>] ? __audit_syscall_entry+0x8c/0xe0
> [<c04add5b>] ? trace_hardirqs_on+0xb/0x10
> [<c04adcac>] ? trace_hardirqs_on_caller+0x13c/0x1e0
> [<c0aeedc0>] ? __do_page_fault+0x5d0/0x5d0
> [<c0aeedda>] do_page_fault+0x1a/0x20
> [<c0aeb7b4>] error_code+0x6c/0x74
> ---[ end trace 0464944e27da06b9 ]---
> Mapped at:
> [<c074eeb2>] debug_dma_alloc_coherent+0x22/0x70
> [<f839de90>] snd_dma_alloc_pages+0x170/0x260 [snd_pcm]
> [<f839dfe2>] snd_dma_alloc_pages_fallback+0x62/0x90 [snd_pcm]
> [<f839e3b0>] snd_malloc_sgbuf_pages+0xf0/0x211 [snd_pcm]
> [<f839df23>] snd_dma_alloc_pages+0x203/0x260 [snd_pcm]
>
>
> https://bugzilla.redhat.com/attachment.cgi?id=888686
>
> dma debug: account for cachelines and read-only mappings in overlap tracking
> https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git/commit/lib/dma-debug.c?id=3b7a6418c7494b8bf0bf0537ddee1dedbca10f51
>
> Are these two in some relation?

Yep.

3.15.0-0.rc2.git1.1.fc21.x86_64 PASSED
3.15.0-0.rc2.git1.1.fc21.i686 FAILED
3.15.0-0.rc2.git1.2.fc21.i686 PASSED <-

3.15.0-0.rc2.git1.2.fc21.i686 is
3.15.0-0.rc2.git1.1.fc21.i686 with reverted linux-next git commit 3b7a641
"dma debug: account for cachelines and read-only mappings in overlap
tracking"
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git/commit/lib/dma-debug.c?id=3b7a641


Information for build kernel-3.15.0-0.rc2.git1.1.fc21
http://koji.fedoraproject.org/koji/buildinfo?buildID=512446


poma