[mythtv-users] Garbled video during first minute of capture

Mike Lewis listemailaccount at gmail.com
Sun Nov 19 03:12:24 UTC 2006


Hi,

Mythtv recently started garbling video during the first minute of
recording and I cannot figure out why.

Here is a viewing sample that I put online.

http://www.youtube.com/watch?v=LpZ2MovlP20

It is a little dark, but watch at exactly 9 seconds in.  There is
digital garble, followed by a small skip.  Then the sound is not in
sync with the video until I bookmark it, exit the video, and replay
from the bookmark.  Mplayer shows the same garble but the A / V sync
is ok.

Gentoo
P4-2.4Ghz
SATA raid 5
.20

Here are interesting log entries:

ivtv-enc: page allocation failure. order:4, mode:0xd0
 [<c014750f>] __alloc_pages+0x1f3/0x2db
 [<c015c97d>] cache_alloc_refill+0x2e3/0x52b
 [<c0120915>] __do_softirq+0x72/0xde
 [<c015cc2e>] __kmalloc+0x69/0x6d
 [<e0bc626f>] ivtv_init_buffer+0x46/0x1ce [ivtv]
 [<e0bc692a>] enc_gather_free_buffers+0xa5/0x247 [ivtv]
 [<c0116039>] __wake_up+0x32/0x43
 [<e0bc89a7>] ivtv_sched_DMA+0x5dd/0xa77 [ivtv]
 [<e0bcdf13>] ivtv_enc_thread+0xcd/0x1ff [ivtv]
 [<c01154a2>] default_wake_function+0x0/0x15
 [<e0bcdfbd>] ivtv_enc_thread+0x177/0x1ff [ivtv]
 [<c012e96e>] autoremove_wake_function+0x0/0x4b
 [<e0bcde46>] ivtv_enc_thread+0x0/0x1ff [ivtv]
 [<c0100db5>] kernel_thread_helper+0x5/0xb
Mem-info:
DMA per-cpu:
cpu 0 hot: high 0, batch 1 used:0
cpu 0 cold: high 0, batch 1 used:0
DMA32 per-cpu: empty
Normal per-cpu:
cpu 0 hot: high 186, batch 31 used:19
cpu 0 cold: high 62, batch 15 used:37
HighMem per-cpu: empty
Free pages:       46444kB (0kB HighMem)
Active:78951 inactive:17478 dirty:13588 writeback:0 unstable:0
free:11611 slab:14728 mapped:8691 pagetables:395
DMA free:2100kB min:88kB low:108kB high:132kB active:7864kB
inactive:0kB present:16384kB pages_scanned:160 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
DMA32 free:0kB min:0kB low:0kB high:0kB active:0kB inactive:0kB
present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
Normal free:44344kB min:2804kB low:3504kB high:4204kB active:307940kB
inactive:69912kB present:507840kB pages_scanned:220 all_unreclaimable?
no
lowmem_reserve[]: 0 0 0 0
HighMem free:0kB min:128kB low:128kB high:128kB active:0kB
inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 7*4kB 1*8kB 1*16kB 10*32kB 7*64kB 2*128kB 0*256kB 0*512kB
1*1024kB 0*2048kB 0*4096kB = 2100kB
DMA32: empty
Normal: 8790*4kB 1042*8kB 29*16kB 0*32kB 0*64kB 3*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 44344kB
HighMem: empty
Swap cache: add 63, delete 63, find 0/0, race 0+0
Free swap  = 2007676kB
Total swap = 2007928kB
Free swap:       2007676kB
131056 pages of RAM
0 pages of HIGHMEM
2553 reserved pages
33563 pages shared
0 pages swap cached
13588 pages dirty
0 pages writeback
8691 pages mapped
14728 pages slab
395 pages pagetables
ivtv1 warning: No memory on buffer alloc!
ivtv1 warning: Needed 14336 bufs for encoder MPEG stream, received 0
(buffers free 0, dma 0, full 177)
ivtv1: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv-enc: page allocation failure. order:4, mode:0xd0
 [<c014750f>] __alloc_pages+0x1f3/0x2db
 [<c015c97d>] cache_alloc_refill+0x2e3/0x52b
 [<c013ffbd>] __do_IRQ+0xdb/0x123
 [<c015cc2e>] __kmalloc+0x69/0x6d
 [<e0bc626f>] ivtv_init_buffer+0x46/0x1ce [ivtv]
 [<e0bc692a>] enc_gather_free_buffers+0xa5/0x247 [ivtv]
 [<c0116039>] __wake_up+0x32/0x43
 [<e0bc89a7>] ivtv_sched_DMA+0x5dd/0xa77 [ivtv]
 [<e0bcdf13>] ivtv_enc_thread+0xcd/0x1ff [ivtv]
 [<c01154a2>] default_wake_function+0x0/0x15
 [<e0bcdfbd>] ivtv_enc_thread+0x177/0x1ff [ivtv]
 [<c012e96e>] autoremove_wake_function+0x0/0x4b
 [<e0bcde46>] ivtv_enc_thread+0x0/0x1ff [ivtv]
 [<c0100db5>] kernel_thread_helper+0x5/0xb
Mem-info:
DMA per-cpu:
cpu 0 hot: high 0, batch 1 used:0
cpu 0 cold: high 0, batch 1 used:0
DMA32 per-cpu: empty
Normal per-cpu:
cpu 0 hot: high 186, batch 31 used:29
cpu 0 cold: high 62, batch 15 used:43
HighMem per-cpu: empty
Free pages:       44412kB (0kB HighMem)
Active:79458 inactive:17407 dirty:19719 writeback:63 unstable:0
free:11103 slab:14776 mapped:8691 pagetables:395
DMA free:2088kB min:88kB low:108kB high:132kB active:7764kB
inactive:116kB present:16384kB pages_scanned:2694 all_unreclaimable?
no
lowmem_reserve[]: 0 0 495 495
DMA32 free:0kB min:0kB low:0kB high:0kB active:0kB inactive:0kB
present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
Normal free:42324kB min:2804kB low:3504kB high:4204kB active:310068kB
inactive:69512kB present:507840kB pages_scanned:221 all_unreclaimable?
no
lowmem_reserve[]: 0 0 0 0
HighMem free:0kB min:128kB low:128kB high:128kB active:0kB
inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 4*4kB 1*8kB 1*16kB 10*32kB 7*64kB 2*128kB 0*256kB 0*512kB
1*1024kB 0*2048kB 0*4096kB = 2088kB
DMA32: empty
Normal: 6477*4kB 1614*8kB 193*16kB 7*32kB 1*64kB 1*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 42324kB
HighMem: empty
Swap cache: add 63, delete 63, find 0/0, race 0+0
Free swap  = 2007676kB
Total swap = 2007928kB
Free swap:       2007676kB
131056 pages of RAM
0 pages of HIGHMEM
2553 reserved pages
33587 pages shared
0 pages swap cached
19719 pages dirty
63 pages writeback
8691 pages mapped
14776 pages slab
395 pages pagetables
ivtv0 warning: No memory on buffer alloc!
ivtv0 warning: Needed 12288 bufs for encoder MPEG stream, received 0
(buffers free 0, dma 0, full 199)
ivtv0: i2c addr 0x44 not found for command 0xc0cc5605!
ata1: no sense translation for status: 0x50
ata1: translated ATA stat/err 0x50/00 to SCSI SK/ASC/ASCQ 0xb/00/00
ata1: status=0x50 { DriveReady SeekComplete }
ata1: no sense translation for status: 0x50
ata1: translated ATA stat/err 0x50/00 to SCSI SK/ASC/ASCQ 0xb/00/00
ata1: status=0x50 { DriveReady SeekComplete }
ata2: no sense translation for status: 0x50
ata2: translated ATA stat/err 0x50/00 to SCSI SK/ASC/ASCQ 0xb/00/00
ata2: status=0x50 { DriveReady SeekComplete }
ata2: no sense translation for status: 0x50
ata2: translated ATA stat/err 0x50/00 to SCSI SK/ASC/ASCQ 0xb/00/00
ata2: status=0x50 { DriveReady SeekComplete }
ivtv1: i2c addr 0x44 not found for command 0xc0445624!
ivtv1: i2c addr 0x44 not found for command 0xc008561c!
ivtv1: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv1: i2c hardware 0x00000001 not found for command 0xc008561c!
ivtv1: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv0: i2c addr 0x44 not found for command 0xc0445624!
ivtv0: i2c addr 0x44 not found for command 0xc008561c!
ivtv0: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv0: i2c hardware 0x00000001 not found for command 0xc008561c!
ivtv0: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv-enc: page allocation failure. order:4, mode:0xd0
 [<c014750f>] __alloc_pages+0x1f3/0x2db
 [<c015c97d>] cache_alloc_refill+0x2e3/0x52b
 [<c015cc2e>] __kmalloc+0x69/0x6d
 [<e0bc626f>] ivtv_init_buffer+0x46/0x1ce [ivtv]
 [<c0433585>] _spin_unlock_irqrestore+0x5/0x1d
 [<e0bc692a>] enc_gather_free_buffers+0xa5/0x247 [ivtv]
 [<c0116039>] __wake_up+0x32/0x43
 [<e0bc89a7>] ivtv_sched_DMA+0x5dd/0xa77 [ivtv]
 [<e0bcdf13>] ivtv_enc_thread+0xcd/0x1ff [ivtv]
 [<c01154a2>] default_wake_function+0x0/0x15
 [<e0bcdfbd>] ivtv_enc_thread+0x177/0x1ff [ivtv]
 [<c012e96e>] autoremove_wake_function+0x0/0x4b
 [<e0bcde46>] ivtv_enc_thread+0x0/0x1ff [ivtv]
 [<c0100db5>] kernel_thread_helper+0x5/0xb
Mem-info:
DMA per-cpu:
cpu 0 hot: high 0, batch 1 used:0
cpu 0 cold: high 0, batch 1 used:0
DMA32 per-cpu: empty
Normal per-cpu:
cpu 0 hot: high 186, batch 31 used:27
cpu 0 cold: high 62, batch 15 used:53
HighMem per-cpu: empty
Free pages:      102908kB (0kB HighMem)
Active:63861 inactive:18144 dirty:263 writeback:0 unstable:0
free:25727 slab:15035 mapped:7347 pagetables:373
DMA free:2124kB min:88kB low:108kB high:132kB active:7564kB
inactive:0kB present:16384kB pages_scanned:96 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
DMA32 free:0kB min:0kB low:0kB high:0kB active:0kB inactive:0kB
present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
Normal free:100784kB min:2804kB low:3504kB high:4204kB active:247880kB
inactive:72576kB present:507840kB pages_scanned:29 all_unreclaimable?
no
lowmem_reserve[]: 0 0 0 0
HighMem free:0kB min:128kB low:128kB high:128kB active:0kB
inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 75*4kB 8*8kB 2*16kB 10*32kB 2*64kB 2*128kB 0*256kB 0*512kB
1*1024kB 0*2048kB 0*4096kB = 2124kB
DMA32: empty
Normal: 14736*4kB 4190*8kB 356*16kB 76*32kB 1*64kB 1*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 100784kB
HighMem: empty
Swap cache: add 9048, delete 8427, find 194/433, race 0+0
Free swap  = 1981348kB
Total swap = 2007928kB
Free swap:       1981348kB
131056 pages of RAM
0 pages of HIGHMEM
2553 reserved pages
26302 pages shared
621 pages swap cached
263 pages dirty
0 pages writeback
7347 pages mapped
15035 pages slab
373 pages pagetables
ivtv1 warning: No memory on buffer alloc!
ivtv1 warning: Needed 12288 bufs for encoder MPEG stream, received 0
(buffers free 0, dma 0, full 213)
ivtv-enc: page allocation failure. order:4, mode:0xd0
 [<c014750f>] __alloc_pages+0x1f3/0x2db
 [<c015c97d>] cache_alloc_refill+0x2e3/0x52b
 [<c015cc2e>] __kmalloc+0x69/0x6d
 [<e0bc626f>] ivtv_init_buffer+0x46/0x1ce [ivtv]
 [<e0bc692a>] enc_gather_free_buffers+0xa5/0x247 [ivtv]
 [<c0116039>] __wake_up+0x32/0x43
 [<e0bc89a7>] ivtv_sched_DMA+0x5dd/0xa77 [ivtv]
 [<e0bcdf13>] ivtv_enc_thread+0xcd/0x1ff [ivtv]
 [<c01154a2>] default_wake_function+0x0/0x15
 [<e0bcdfbd>] ivtv_enc_thread+0x177/0x1ff [ivtv]
 [<c012e96e>] autoremove_wake_function+0x0/0x4b
 [<e0bcde46>] ivtv_enc_thread+0x0/0x1ff [ivtv]
 [<c0100db5>] kernel_thread_helper+0x5/0xb
Mem-info:
DMA per-cpu:
cpu 0 hot: high 0, batch 1 used:0
cpu 0 cold: high 0, batch 1 used:0
DMA32 per-cpu: empty
Normal per-cpu:
cpu 0 hot: high 186, batch 31 used:12
cpu 0 cold: high 62, batch 15 used:47
HighMem per-cpu: empty
Free pages:      131464kB (0kB HighMem)
Active:57870 inactive:17002 dirty:273 writeback:0 unstable:0
free:32866 slab:15048 mapped:7347 pagetables:373
DMA free:2124kB min:88kB low:108kB high:132kB active:7564kB
inactive:0kB present:16384kB pages_scanned:768 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
DMA32 free:0kB min:0kB low:0kB high:0kB active:0kB inactive:0kB
present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 495 495
Normal free:129340kB min:2804kB low:3504kB high:4204kB active:223916kB
inactive:68008kB present:507840kB pages_scanned:14 all_unreclaimable?
no
lowmem_reserve[]: 0 0 0 0
HighMem free:0kB min:128kB low:128kB high:128kB active:0kB
inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0 0 0
DMA: 75*4kB 8*8kB 2*16kB 10*32kB 2*64kB 2*128kB 0*256kB 0*512kB
1*1024kB 0*2048kB 0*4096kB = 2124kB
DMA32: empty
Normal: 17163*4kB 5798*8kB 704*16kB 89*32kB 1*64kB 1*128kB 0*256kB
0*512kB 0*1024kB 0*2048kB 0*4096kB = 129340kB
HighMem: empty
Swap cache: add 9056, delete 8427, find 197/437, race 0+0
Free swap  = 1981348kB
Total swap = 2007928kB
Free swap:       1981348kB
131056 pages of RAM
0 pages of HIGHMEM
2553 reserved pages
26303 pages shared
629 pages swap cached
273 pages dirty
0 pages writeback
7347 pages mapped
15048 pages slab
373 pages pagetables
ivtv0 warning: No memory on buffer alloc!
ivtv0 warning: Needed 14336 bufs for encoder MPEG stream, received 0
(buffers free 0, dma 0, full 194)
ivtv1: i2c addr 0x44 not found for command 0xc0cc5605!
ivtv0: i2c addr 0x44 not found for command 0xc0cc5605


More information about the mythtv-users mailing list