#613 dma_single_capture hangs - Split packet size exceeded: dma p

[Marcio Cabral]

After capturing and displaying a few frames, dmesg
shows these:

ohci1394: fw-host0: Split packet size exceeded: dma prg
stopped
ohci1394: fw-host0: Split packet size exceeded: dma prg
stopped

and the program locks on the line of

dma_single_capture(..)

Here are the details:
# kernel version
Fedora Core 2
2.6.6-1.427.8kstacks

# libraw version
libraw1394-devel-0.10.1-1
libraw1394-0.10.1-1
libdc1394-0.9.4

# which driver: OHCI

# relevant messages from dmesg
ieee1394: raw1394: /dev/raw1394 device initialized
ohci1394: $Rev: 1203 $ Ben Collins <bcollins@debian.org>
ohci1394: fw-host0: Unexpected PCI resource length of 1000!
ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[10]
MMIO=[f4000000-f40007ff] Max Packet=[2048]
video1394: Installed video1394 module
ieee1394: Host added: ID:BUS[0-00:1023]
GUID[0040d001001a5049]
ieee1394: Node added: ID:BUS[0-01:1023]
GUID[00b09d01003233ba]
ieee1394: Node added: ID:BUS[0-02:1023]
GUID[00b09d01003233bc]
ieee1394: The root node is not cycle master capable;
selecting a new root node and resetting...
ieee1394: Node changed: 0-01:1023 -> 0-00:1023
ieee1394: Node changed: 0-02:1023 -> 0-01:1023
ieee1394: Node changed: 0-00:1023 -> 0-03:1023
Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0114308>] do_page_fault+0x11d/0x434
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
include/asm/semaphore.h:119
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c01db966>] dma_pool_destroy+0x18/0x113
[<e0baac25>] free_dma_rcv_ctx+0xa5/0xce [ohci1394]
[<e0ba8f76>] ohci_devctl+0x459/0x47a [ohci1394]
[<e0b64e24>] hpsb_unlisten_channel+0x3b/0x3e [ieee1394]
[<e0b1e9da>] handle_iso_listen+0x102/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
include/asm/semaphore.h:119
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c01db966>] dma_pool_destroy+0x18/0x113
[<e0baac25>] free_dma_rcv_ctx+0xa5/0xce [ohci1394]
[<e0ba8f76>] ohci_devctl+0x459/0x47a [ohci1394]
[<e0b64e24>] hpsb_unlisten_channel+0x3b/0x3e [ieee1394]
[<e0b1e9da>] handle_iso_listen+0x102/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

Debug: sleeping function called from invalid context at
mm/slab.c:1996
in_atomic():0, irqs_disabled():1
[<c01165f3>] __might_sleep+0x80/0x8a
[<c0131eca>] __kmalloc+0x40/0x76
[<e0baacad>] alloc_dma_rcv_ctx+0x5f/0x379 [ohci1394]
[<e0ba8cf9>] ohci_devctl+0x1dc/0x47a [ohci1394]
[<c0135af6>] unmap_page_range+0x3c/0x57
[<e0b64de2>] hpsb_listen_channel+0x42/0x49 [ieee1394]
[<e0b1e95d>] handle_iso_listen+0x85/0x142 [raw1394]
[<e0b20a06>] state_connected+0xea/0x1c7 [raw1394]
[<e0b20b61>] raw1394_write+0x7e/0x92 [raw1394]
[<c01417ec>] vfs_write+0xb8/0xe4
[<c0141886>] sys_write+0x2c/0x42
[<c0105e5f>] syscall_call+0x7/0xb

ohci1394: fw-host0: Split packet size exceeded: dma prg
stopped
ohci1394: fw-host0: Split packet size exceeded: dma prg
stopped

# adapter card model and/or OHCI chipset
Sharp Notebook RD3D

# output of lspci
00:00.0 Host bridge: Silicon Integrated Systems [SiS]
SiS645DX Host & Memory & AGP Controller (rev 01)00:01.0
PCI bridge: Silicon Integrated Systems [SiS] Virtual
PCI-to-PCI bridge (AGP)
00:02.0 ISA bridge: Silicon Integrated Systems [SiS]
SiS962 [MuTIOL Media IO] (rev 14)
00:02.1 SMBus: Silicon Integrated Systems [SiS]:
Unknown device 0016
00:02.3 FireWire (IEEE 1394): Silicon Integrated
Systems [SiS] FireWire Controller
00:02.5 IDE interface: Silicon Integrated Systems [SiS]
5513 [IDE]
00:02.6 Modem: Silicon Integrated Systems [SiS] AC'97
Modem Controller (rev a0)
00:02.7 Multimedia audio controller: Silicon Integrated
Systems [SiS] Sound Controller (rev a0)
00:03.0 USB Controller: Silicon Integrated Systems
[SiS] USB 1.0 Controller (rev 0f)
00:03.1 USB Controller: Silicon Integrated Systems
[SiS] USB 1.0 Controller (rev 0f)
00:03.2 USB Controller: Silicon Integrated Systems
[SiS] USB 1.0 Controller (rev 0f)
00:03.3 USB Controller: Silicon Integrated Systems
[SiS] USB 2.0 Controller
00:04.0 Ethernet controller: Silicon Integrated Systems
[SiS] SiS900 PCI Fast Ethernet (rev 90)
00:09.0 CardBus bridge: Texas Instruments PCI1410 PC
card Cardbus Controller (rev 01)
01:00.0 VGA compatible controller: nVidia Corporation
NV17 [GeForce4 440 Go 64M] (rev a3)
02:00.0 Ethernet controller: Atheros Communications,
Inc. AR5212 802.11abg NIC (rev 0)

I am running into the same problems running debian sarge.

Any help is greatly appreciated,

Thanks,
Marcio