Bug 947250

Summary: 8139cp: WARNING: at lib/dma-debug.c:937 check_unmap+0x47d/0x930() (when KVM network type=default)
Product: [Fedora] Fedora Reporter: Reartes Guillermo <rtguille>
Component: kernelAssignee: Neil Horman <nhorman>
Status: CLOSED NEXTRELEASE QA Contact: Fedora Extras Quality Assurance <extras-qa>
Severity: medium Docs Contact:
Priority: unspecified    
Version: 19CC: gansalmon, itamar, jonathan, kernel-maint, madhu.chinakonda, nhorman, rhack, rtguille
Target Milestone: ---   
Target Release: ---   
Hardware: x86_64   
OS: Linux   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2013-08-01 17:33:18 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:
Attachments:
Description Flags
syslog (final black screen) guest FNEXt-TST3 vith network:default
none
syslog (final black screen) guest FNEXt-TST3 vith network:default with more ram
none
[PATCH] 8139cp: Add dma_mapping_error checking none

Description Reartes Guillermo 2013-04-01 22:51:07 UTC 
Created attachment 730502 [details]
syslog (final black screen) guest FNEXt-TST3 vith network:default

Description of problem:

Booting the media, the kernel issues a call trace when the network card is of type default. There is not a call trace when the network is virtio. 

Also the guest that experiences the call trace ends in a black screen, maybe 
it is just a coincidence but it might me related to bug 928287.

Version-Release number of selected component (if applicable):
F19a TC3 (19.14) 
Kernel: 3.9.0-0.rc4.git0.1.fc19.x86_64

How reproducible:
always

Steps to Reproduce:
1. boot the media (f19a tc3)
2. check the logs on another vt.
  
Actual results:
call trace
black screen at the end of the installation (might not be related and just a coincidence, but i don't know yet).

Expected results:
no call trace

Additional info:
The call trace happens on boot, it is not required to start the install for it to happen.
Comment 1 Reartes Guillermo 2013-04-01 22:51:42 UTC 
Created attachment 730503 [details]
syslog (final black screen) guest FNEXt-TST3 vith network:default with more ram
Comment 2 Reartes Guillermo 2013-04-01 22:52:28 UTC 
19:54:33,031 INFO systemd: Starting Anaconda...
19:54:33,047 INFO kernel:[   37.047530] 8139cp 0000:00:03.0 ens3: link up, 100Mbps, full-duplex, lpa 0x05E1
19:54:33,052 WARNING kernel:[   37.052737] ------------[ cut here ]------------
19:54:33,053 WARNING kernel:[   37.052745] WARNING: at lib/dma-debug.c:937 check_unmap+0x47d/0x930()
19:54:33,053 WARNING kernel:[   37.052747] Hardware name: Bochs
19:54:33,053 WARNING kernel:[   37.052749] 8139cp 0000:00:03.0: DMA-API: device driver failed to check map error[device address=0x00000000216ec0fa] [size=90 bytes] [mapped as single]
19:54:33,053 WARNING kernel:[   37.052751] Modules linked in: joydev virtio_balloon i2c_piix4 uinput nls_utf8 isofs 8139too qxl drm_kms_helper ttm drm 8139cp mii i2c_core sunrpc dm_crypt dm_round_robin dm_multipath linear raid10 raid456 async_raid6_recov async_memcpy async_pq raid6_pq async_xor xor async_tx raid1 raid0 iscsi_ibft iscsi_boot_sysfs floppy scsi_dh_rdac scsi_dh_hp_sw scsi_dh_emc scsi_dh_alua iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi squashfs cramfs edd
19:54:33,053 WARNING kernel:[   37.052787] Pid: 579, comm: systemd-udevd Not tainted 3.9.0-0.rc4.git0.1.fc19.x86_64 #1
19:54:33,053 WARNING kernel:[   37.052789] Call Trace:
19:54:33,053 WARNING kernel:[   37.052791]  <IRQ>  [<ffffffff81068df0>] warn_slowpath_common+0x70/0xa0
19:54:33,053 WARNING kernel:[   37.052800]  [<ffffffff81068e6c>] warn_slowpath_fmt+0x4c/0x50
19:54:33,053 WARNING kernel:[   37.052805]  [<ffffffff8137e8ed>] check_unmap+0x47d/0x930
19:54:33,053 WARNING kernel:[   37.052810]  [<ffffffff810e6192>] ? __module_text_address+0x12/0x60
19:54:33,053 WARNING kernel:[   37.052814]  [<ffffffff8137edff>] debug_dma_unmap_page+0x5f/0x70
19:54:33,053 WARNING kernel:[   37.052820]  [<ffffffffa016dbd0>] cp_interrupt+0x2f0/0x5b0 [8139cp]
19:54:33,053 WARNING kernel:[   37.052824]  [<ffffffff811193b6>] handle_irq_event_percpu+0x56/0x390
19:54:33,053 WARNING kernel:[   37.052827]  [<ffffffff8111972d>] handle_irq_event+0x3d/0x60
19:54:33,053 WARNING kernel:[   37.052830]  [<ffffffff8111c8ea>] handle_fasteoi_irq+0x5a/0x100
19:54:33,053 WARNING kernel:[   37.052834]  [<ffffffff8101c36f>] handle_irq+0xbf/0x150
19:54:33,053 WARNING kernel:[   37.052837]  [<ffffffff81073800>] ? irq_enter+0x50/0xa0
19:54:33,053 WARNING kernel:[   37.052840]  [<ffffffff8172900d>] do_IRQ+0x4d/0xc0
19:54:33,053 WARNING kernel:[   37.052843]  [<ffffffff8171e332>] common_interrupt+0x72/0x72
19:54:33,053 WARNING kernel:[   37.052847]  [<ffffffff8171d6c6>] ? _raw_spin_unlock_irqrestore+0x36/0x70
19:54:33,053 WARNING kernel:[   37.052851]  [<ffffffffa016f9e0>] ? cp_start_xmit+0x2b0/0x954 [8139cp]
19:54:33,053 WARNING kernel:[   37.052856]  [<ffffffff815d8f89>] dev_hard_start_xmit+0x259/0x6b0
19:54:33,053 WARNING kernel:[   37.052861]  [<ffffffff815fbfde>] sch_direct_xmit+0xee/0x290
19:54:33,053 WARNING kernel:[   37.052864]  [<ffffffff815d9639>] dev_queue_xmit+0x259/0x970
19:54:33,053 WARNING kernel:[   37.052867]  [<ffffffff815d93e5>] ? dev_queue_xmit+0x5/0x970
19:54:33,053 WARNING kernel:[   37.052870]  [<ffffffff815e31f7>] neigh_resolve_output+0x127/0x280
19:54:33,053 WARNING kernel:[   37.052874]  [<ffffffff8169fe1c>] ip6_finish_output2+0x1dc/0x790
19:54:33,053 WARNING kernel:[   37.052876]  [<ffffffff8169fc97>] ? ip6_finish_output2+0x57/0x790
19:54:33,053 WARNING kernel:[   37.052879]  [<ffffffff816a3b80>] ip6_finish_output+0xa0/0x210
19:54:33,053 WARNING kernel:[   37.052882]  [<ffffffff816a3d3f>] ip6_output+0x4f/0x1e0
19:54:33,053 WARNING kernel:[   37.052885]  [<ffffffff816c965f>] mld_sendpack+0x1cf/0x4b0
19:54:33,053 WARNING kernel:[   37.052887]  [<ffffffff816c9495>] ? mld_sendpack+0x5/0x4b0
19:54:33,053 WARNING kernel:[   37.052890]  [<ffffffff816ca0d4>] mld_ifc_timer_expire+0x194/0x280
19:54:33,053 WARNING kernel:[   37.052893]  [<ffffffff816c9f40>] ? mld_gq_timer_expire+0x30/0x30
19:54:33,053 WARNING kernel:[   37.052896]  [<ffffffff8107c15a>] call_timer_fn+0x8a/0x340
19:54:33,053 WARNING kernel:[   37.052898]  [<ffffffff8107c0d5>] ? call_timer_fn+0x5/0x340
19:54:33,053 WARNING kernel:[   37.052901]  [<ffffffff816c9f40>] ? mld_gq_timer_expire+0x30/0x30
19:54:33,053 WARNING kernel:[   37.052903]  [<ffffffff8107c634>] run_timer_softirq+0x224/0x380
19:54:33,053 WARNING kernel:[   37.052906]  [<ffffffff8107343f>] __do_softirq+0xff/0x400
19:54:33,053 WARNING kernel:[   37.052909]  [<ffffffff81073905>] irq_exit+0xb5/0xc0
19:54:33,053 WARNING kernel:[   37.052912]  [<ffffffff817290ee>] smp_apic_timer_interrupt+0x6e/0x9c
19:54:33,053 WARNING kernel:[   37.052914]  [<ffffffff81727fb2>] apic_timer_interrupt+0x72/0x80
19:54:33,053 WARNING kernel:[   37.052915]  <EOI>  [<ffffffff810acdc8>] ? sched_clock_cpu+0xa8/0x100
19:54:33,053 WARNING kernel:[   37.052922]  [<ffffffff810daeea>] ? lock_acquire+0xba/0x1f0
19:54:33,053 WARNING kernel:[   37.052925]  [<ffffffff811f45a5>] ? __d_lookup+0x5/0x320
19:54:33,053 WARNING kernel:[   37.052928]  [<ffffffff811f4628>] __d_lookup+0x88/0x320
19:54:33,053 WARNING kernel:[   37.052930]  [<ffffffff811f45a5>] ? __d_lookup+0x5/0x320
19:54:33,053 WARNING kernel:[   37.052933]  [<ffffffff811e649a>] lookup_fast+0x16a/0x2d0
19:54:33,053 WARNING kernel:[   37.052936]  [<ffffffff812edcbc>] ? security_inode_permission+0x1c/0x30
19:54:33,053 WARNING kernel:[   37.052938]  [<ffffffff811e6a44>] ? __inode_permission+0x54/0xc0
19:54:33,053 WARNING kernel:[   37.052941]  [<ffffffff811e739b>] link_path_walk+0x1ab/0x910
19:54:33,053 WARNING kernel:[   37.052944]  [<ffffffff811e7c57>] path_lookupat+0x57/0x7e0
19:54:33,053 WARNING kernel:[   37.052947]  [<ffffffff811bf1aa>] ? kmem_cache_alloc+0xea/0x360
19:54:33,053 WARNING kernel:[   37.052950]  [<ffffffff811e840b>] filename_lookup+0x2b/0xc0
19:54:33,053 WARNING kernel:[   37.052953]  [<ffffffff811eb1e4>] user_path_at_empty+0x54/0x90
19:54:33,053 WARNING kernel:[   37.052956]  [<ffffffff811e67c2>] ? final_putname+0x22/0x50
19:54:33,053 WARNING kernel:[   37.052958]  [<ffffffff811bb902>] ? kmem_cache_free+0x372/0x380
19:54:33,053 WARNING kernel:[   37.052961]  [<ffffffff811e029c>] sys_readlinkat+0x4c/0x130
19:54:33,053 WARNING kernel:[   37.052964]  [<ffffffff813679ee>] ? trace_hardirqs_on_thunk+0x3a/0x3f
19:54:33,053 WARNING kernel:[   37.052967]  [<ffffffff811e039b>] sys_readlink+0x1b/0x20
19:54:33,053 WARNING kernel:[   37.052969]  [<ffffffff81727319>] system_call_fastpath+0x16/0x1b
19:54:33,053 WARNING kernel:[   37.052971] ---[ end trace ad6c5b356a50c4a5 ]---
19:54:33,053 WARNING kernel:[   37.052972] Mapped at:
19:54:33,053 WARNING kernel:[   37.052973]  [<ffffffff8137e031>] debug_dma_map_page+0x91/0x140
19:54:33,053 WARNING kernel:[   37.052976]  [<ffffffffa016f8ec>] cp_start_xmit+0x1bc/0x954 [8139cp]
19:54:33,053 WARNING kernel:[   37.052979]  [<ffffffff815d8f89>] dev_hard_start_xmit+0x259/0x6b0
19:54:33,053 WARNING kernel:[   37.052981]  [<ffffffff815fbfde>] sch_direct_xmit+0xee/0x290
19:54:33,053 WARNING kernel:[   37.052984]  [<ffffffff815d9639>] dev_queue_xmit+0x259/0x970
19:54:33,062 INFO systemd: Starting Network Manager Wait Online...
Comment 3 Reartes Guillermo 2013-04-01 22:52:44 UTC 
21:13:21,856 INFO NetworkManager: <info> Networking is enabled by state file
21:13:21,875 WARNING NetworkManager: <warn> failed to allocate link cache: (-10) Operation not supported
21:13:21,891 INFO kernel:[   36.890198] 8139cp 0000:00:03.0 ens3: link up, 100Mbps, full-duplex, lpa 0x05E1
21:13:21,895 WARNING kernel:[   36.895728] ------------[ cut here ]------------
21:13:21,895 WARNING kernel:[   36.895735] WARNING: at lib/dma-debug.c:937 check_unmap+0x47d/0x930()
21:13:21,895 WARNING kernel:[   36.895737] Hardware name: Bochs
21:13:21,895 WARNING kernel:[   36.895739] 8139cp 0000:00:03.0: DMA-API: device driver failed to check map error[device address=0x0000000073b137b2] [size=90 bytes] [mapped as single]
21:13:21,895 WARNING kernel:[   36.895741] Modules linked in: joydev virtio_balloon i2c_piix4 uinput nls_utf8 isofs 8139too qxl drm_kms_helper ttm drm 8139cp i2c_core mii sunrpc dm_crypt dm_round_robin dm_multipath linear raid10 raid456 async_raid6_recov async_memcpy async_pq raid6_pq async_xor xor async_tx raid1 raid0 iscsi_ibft iscsi_boot_sysfs floppy scsi_dh_rdac scsi_dh_hp_sw scsi_dh_emc scsi_dh_alua iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi squashfs cramfs edd
21:13:21,895 WARNING kernel:[   36.895771] Pid: 484, comm: systemd-journal Not tainted 3.9.0-0.rc4.git0.1.fc19.x86_64 #1
21:13:21,895 WARNING kernel:[   36.895773] Call Trace:
21:13:21,895 WARNING kernel:[   36.895774]  <IRQ>  [<ffffffff81068df0>] warn_slowpath_common+0x70/0xa0
21:13:21,895 WARNING kernel:[   36.895782]  [<ffffffff81068e6c>] warn_slowpath_fmt+0x4c/0x50
21:13:21,895 WARNING kernel:[   36.895787]  [<ffffffff8137e8ed>] check_unmap+0x47d/0x930
21:13:21,895 WARNING kernel:[   36.895791]  [<ffffffff810e6192>] ? __module_text_address+0x12/0x60
21:13:21,895 WARNING kernel:[   36.895794]  [<ffffffff8137edff>] debug_dma_unmap_page+0x5f/0x70
21:13:21,895 WARNING kernel:[   36.895800]  [<ffffffffa0188bd0>] cp_interrupt+0x2f0/0x5b0 [8139cp]
21:13:21,895 WARNING kernel:[   36.895804]  [<ffffffff811193b6>] handle_irq_event_percpu+0x56/0x390
21:13:21,895 WARNING kernel:[   36.895807]  [<ffffffff8111972d>] handle_irq_event+0x3d/0x60
21:13:21,895 WARNING kernel:[   36.895810]  [<ffffffff8111c8ea>] handle_fasteoi_irq+0x5a/0x100
21:13:21,895 WARNING kernel:[   36.895813]  [<ffffffff8101c36f>] handle_irq+0xbf/0x150
21:13:21,895 WARNING kernel:[   36.895817]  [<ffffffff81073800>] ? irq_enter+0x50/0xa0
21:13:21,895 WARNING kernel:[   36.895820]  [<ffffffff8172900d>] do_IRQ+0x4d/0xc0
21:13:21,895 WARNING kernel:[   36.895823]  [<ffffffff8171e332>] common_interrupt+0x72/0x72
21:13:21,895 WARNING kernel:[   36.895827]  [<ffffffff8171d6c6>] ? _raw_spin_unlock_irqrestore+0x36/0x70
21:13:21,895 WARNING kernel:[   36.895832]  [<ffffffffa018a9e0>] ? cp_start_xmit+0x2b0/0x954 [8139cp]
21:13:21,895 WARNING kernel:[   36.895836]  [<ffffffff815d8f89>] dev_hard_start_xmit+0x259/0x6b0
21:13:21,895 WARNING kernel:[   36.895841]  [<ffffffff815fbfde>] sch_direct_xmit+0xee/0x290
21:13:21,895 WARNING kernel:[   36.895844]  [<ffffffff815d9639>] dev_queue_xmit+0x259/0x970
21:13:21,895 WARNING kernel:[   36.895847]  [<ffffffff815d93e5>] ? dev_queue_xmit+0x5/0x970
21:13:21,895 WARNING kernel:[   36.895850]  [<ffffffff815e31f7>] neigh_resolve_output+0x127/0x280
21:13:21,895 WARNING kernel:[   36.895853]  [<ffffffff8169fe1c>] ip6_finish_output2+0x1dc/0x790
21:13:21,895 WARNING kernel:[   36.895856]  [<ffffffff8169fc97>] ? ip6_finish_output2+0x57/0x790
21:13:21,895 WARNING kernel:[   36.895859]  [<ffffffff816a3b80>] ip6_finish_output+0xa0/0x210
21:13:21,895 WARNING kernel:[   36.895861]  [<ffffffff816a3d3f>] ip6_output+0x4f/0x1e0
21:13:21,895 WARNING kernel:[   36.895864]  [<ffffffff816c965f>] mld_sendpack+0x1cf/0x4b0
21:13:21,895 WARNING kernel:[   36.895867]  [<ffffffff816c9495>] ? mld_sendpack+0x5/0x4b0
21:13:21,895 WARNING kernel:[   36.895870]  [<ffffffff816ca0d4>] mld_ifc_timer_expire+0x194/0x280
21:13:21,895 WARNING kernel:[   36.895872]  [<ffffffff816c9f40>] ? mld_gq_timer_expire+0x30/0x30
21:13:21,895 WARNING kernel:[   36.895875]  [<ffffffff8107c15a>] call_timer_fn+0x8a/0x340
21:13:21,895 WARNING kernel:[   36.895877]  [<ffffffff8107c0d5>] ? call_timer_fn+0x5/0x340
21:13:21,895 WARNING kernel:[   36.895880]  [<ffffffff816c9f40>] ? mld_gq_timer_expire+0x30/0x30
21:13:21,895 WARNING kernel:[   36.895882]  [<ffffffff8107c634>] run_timer_softirq+0x224/0x380
21:13:21,895 WARNING kernel:[   36.895886]  [<ffffffff8119e120>] ? unlink_anon_vmas+0x120/0x180
21:13:21,896 WARNING kernel:[   36.895888]  [<ffffffff8107343f>] __do_softirq+0xff/0x400
21:13:21,896 WARNING kernel:[   36.895891]  [<ffffffff8119e120>] ? unlink_anon_vmas+0x120/0x180
21:13:21,896 WARNING kernel:[   36.895894]  [<ffffffff81073905>] irq_exit+0xb5/0xc0
21:13:21,896 WARNING kernel:[   36.895896]  [<ffffffff817290ee>] smp_apic_timer_interrupt+0x6e/0x9c
21:13:21,896 WARNING kernel:[   36.895899]  [<ffffffff81727fb2>] apic_timer_interrupt+0x72/0x80
21:13:21,896 WARNING kernel:[   36.895900]  <EOI>  [<ffffffff8171d6cb>] ? _raw_spin_unlock_irqrestore+0x3b/0x70
21:13:21,896 WARNING kernel:[   36.895907]  [<ffffffff8171378f>] __slab_free+0x58/0x38b
21:13:21,896 WARNING kernel:[   36.895910]  [<ffffffff8137183e>] ? debug_check_no_obj_freed+0x14e/0x250
21:13:21,896 WARNING kernel:[   36.895913]  [<ffffffff811bb647>] ? kmem_cache_free+0xb7/0x380
21:13:21,896 WARNING kernel:[   36.895915]  [<ffffffff8119e120>] ? unlink_anon_vmas+0x120/0x180
21:13:21,896 WARNING kernel:[   36.895918]  [<ffffffff811bb902>] kmem_cache_free+0x372/0x380
21:13:21,896 WARNING kernel:[   36.895920]  [<ffffffff8119e120>] unlink_anon_vmas+0x120/0x180
21:13:21,896 WARNING kernel:[   36.895924]  [<ffffffff8118f370>] free_pgtables+0x40/0x120
21:13:21,896 WARNING kernel:[   36.895927]  [<ffffffff8119673a>] unmap_region+0xaa/0x100
21:13:21,896 WARNING kernel:[   36.895929]  [<ffffffff81196b71>] ? vma_rb_erase+0x121/0x220
21:13:21,896 WARNING kernel:[   36.895932]  [<ffffffff81198a02>] do_munmap+0x242/0x410
21:13:21,896 WARNING kernel:[   36.895935]  [<ffffffff81198c14>] vm_munmap+0x44/0x60
21:13:21,896 WARNING kernel:[   36.895937]  [<ffffffff81199b52>] sys_munmap+0x22/0x30
21:13:21,896 WARNING kernel:[   36.895940]  [<ffffffff81727319>] system_call_fastpath+0x16/0x1b
21:13:21,896 WARNING kernel:[   36.895941] ---[ end trace c68f7698de99cded ]---
21:13:21,896 WARNING kernel:[   36.895943] Mapped at:
21:13:21,896 WARNING kernel:[   36.895944]  [<ffffffff8137e031>] debug_dma_map_page+0x91/0x140
21:13:21,896 WARNING kernel:[   36.895947]  [<ffffffffa018a8ec>] cp_start_xmit+0x1bc/0x954 [8139cp]
21:13:21,896 WARNING kernel:[   36.895950]  [<ffffffff815d8f89>] dev_hard_start_xmit+0x259/0x6b0
21:13:21,896 WARNING kernel:[   36.895952]  [<ffffffff815fbfde>] sch_direct_xmit+0xee/0x290
21:13:21,896 WARNING kernel:[   36.895954]  [<ffffffff815d9639>] dev_queue_xmit+0x259/0x970
21:13:21,930 INFO NetworkManager: <info> (ens3): carrier is OFF
Comment 4 Josh Boyer 2013-05-08 19:17:03 UTC 
*** Bug 926009 has been marked as a duplicate of this bug. ***
Comment 5 Josh Boyer 2013-05-16 14:03:23 UTC 
*** Bug 954277 has been marked as a duplicate of this bug. ***
Comment 6 Neil Horman 2013-06-28 16:27:31 UTC 
Created attachment 766663 [details]
[PATCH] 8139cp: Add dma_mapping_error checking


Self explanitory:

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

Showed several backtraces arising for dma_map_* usage without checking the
return code on the mapping.  Add the check and abort the rx/tx operation if its
failed.  Teseted by the reporter

Signed-off-by: Neil Horman <nhorman>
---
 drivers/net/ethernet/realtek/8139cp.c | 25 +++++++++++++++++++++++++
 1 file changed, 25 insertions(+)
Comment 7 Neil Horman 2013-06-28 16:44:30 UTC 
http://koji.fedoraproject.org/koji/taskinfo?taskID=5554650


Heres a build with a fix for the issue, plese test and confirm that it solves your problem.  Thanks!
Comment 8 Neil Horman 2013-07-12 13:54:32 UTC 
ping, any feedback?
Comment 9 Neil Horman 2013-08-01 17:33:18 UTC 
Got it fixed upstream, since there was no feedback on this I'll just let it get fixed in f20