Advanced
Mailing List Archive

Mailing List Archive

  1. Home >
  2. ivtv>
  3. users
Problems with cx-18 and Hauppage WinTV-HVR-1600
windsunrain at gmail
Oct 25, 2009, 7:38 AM
Post #1 of 9 (5456 views)
Permalink
Hello,

I'm having some problems with the Hauppage WinTV-HVR-1600 that I
recently bought. I'm running Jaunty on a system with an ASUS A7V333
motherboard with BIOS version 1017, AMD Athlon XP 1800+ and nVideo
GeForce 7600 GT video card with 256mb ram. The WinTV-HVR-1600 is the
kind with the MCE remote. Current kernel is labeled 2.6.28-16-generic
#55-Ubuntu SMP and I installed the
cx-18 module as per http://www.mythtv.org/wiki/Hauppauge_HVR-1600

I'm having two problems:

- Analog video has no sound.
- Changing the channel on the analog tuner stops playback and seems to
lock up all use of the WinTV-HVR-1600

I hope you guys can help me resolve these problems.

Here is a typical session:

System startup:

[ 14.927186] cx18: Start initialization, version 1.2.0
[ 14.927973] cx18-0: Initializing card 0
[ 14.927983] cx18-0: Autodetected Hauppauge card
[ 14.937864] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
IRQ 17
[ 14.937975] cx18-0: Unreasonably low latency timer, setting to 64
(was 32)
[ 14.943431] cx18-0: cx23418 revision 01010000 (B)
[ 15.234170] tveeprom 1-0050: Hauppauge model 74541, rev C6B6, serial#
6314962
[ 15.234179] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
[ 15.234184] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
116, type 43)
[ 15.234190] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
[ 15.234195] tveeprom 1-0050: audio processor is CX23418 (idx 38)
[ 15.234199] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
[ 15.234203] tveeprom 1-0050: has radio
[ 15.234207] cx18-0: Autodetected Hauppauge HVR-1600
[ 15.234213] cx18-0: Simultaneous Digital and Analog TV capture
supported
[ 15.421386] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
[ 15.440345] tda9887 2-0043: creating new instance
[ 15.440354] tda9887 2-0043: tda988[5/6/7] found
[ 15.446498] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
[ 15.467427] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
[ 15.491851] tuner-simple 2-0061: creating new instance
[ 15.491862] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
(FM1236MK3 or FM1236/F))
[ 15.494124] cx18-0: Registered device video0 for encoder MPEG (64 x
32 kB)
[ 15.494132] DVB: registering new adapter (cx18)
[ 15.612500] MXL5005S: Attached at address 0x63
[ 15.612516] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
QAM/8VSB Frontend)...
[ 15.612934] cx18-0: DVB Frontend registered
[ 15.612941] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
[ 15.613067] cx18-0: Registered device video32 for encoder YUV (16 x
128 kB)
[ 15.613238] cx18-0: Registered device vbi0 for encoder VBI (20 x
51984 bytes)
[ 15.613341] cx18-0: Registered device video24 for encoder PCM audio
(256 x 4 kB)
[ 15.613438] cx18-0: Registered device radio0 for encoder radio
[ 15.613444] cx18-0: Initialized card: Hauppauge HVR-1600
[ 15.613539] cx18: End initialization
[ 15.678354] C-Media PCI 0000:00:05.0: PCI INT A -> GSI 17 (level,
low) -> IRQ 17
[ 22.928450] ivtv: Start initialization, version 1.4.1
[ 22.928559] ivtv: End initialization
[ 22.945289] lirc_pvr150: disagrees about version of symbol
ivtv_reset_ir_gpio
[ 22.945302] lirc_pvr150: Unknown symbol ivtv_reset_ir_gpio
[ 30.604990] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-cpu.fw
[ 30.771584] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332 bytes)
[ 30.795006] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-apu.fw
[ 30.964545] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
(141200 bytes)
[ 30.973159] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
[ 31.300412] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-cpu.fw
[ 31.462333] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-apu.fw
[ 31.801713] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-dig.fw
[ 31.991741] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
bytes)
[ 32.009660] cx18-0 843: verified load of v4l-cx23418-dig.fw firmware
(16382 bytes)

It's not clear to me why driver reports that firmware is requesting apu
and cpu again after reporting that they are loaded.

I think the C-Media PCI line is for the onboard sound, not the HVR-1600,
but I've left it in here because it's sharing interrupt 17 with cx-18.
cat /proc/interrupts:

17: 57174 IO-APIC-fasteoi ehci_hcd:usb1, cx18-0, CMI8738-MC6

Is it possible that this interrupt sharing causes the lockups and lack
of sound?

Alright. Start MythTV, go to watch TV. Analog playback starts, but there
is no audio. Nothing in kernel log.

Now change the channel in MythTV. Playback stops indefinitely. Kernel
log shows this:
[ 1057.324029] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1057.348043] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1057.372025] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.332033] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_CAPTURE_STOP; clearing busy and trying to proceed
[ 1062.364024] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_RELEASE_MDL; clearing busy and trying to proceed
[ 1062.396025] cx18-0: mbox was found stuck busy when setting up for
CX18_DESTROY_TASK; clearing busy and trying to proceed
[ 1062.428038] cx18-0: mbox was found stuck busy when setting up for
CX18_CREATE_TASK; clearing busy and trying to proceed
[ 1062.467782] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_CHANNEL_TYPE; clearing busy and trying to proceed
[ 1062.496033] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_VER_CROP_LINE; clearing busy and trying to proceed
[ 1062.528036] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
[ 1062.560034] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
[ 1062.592040] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
[ 1062.624030] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
[ 1062.656039] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_CAPTURE_LINE_NO; clearing busy and trying to proceed
[ 1062.688175] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_RAW_VBI_PARAM; clearing busy and trying to proceed
[ 1062.720046] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_INDEXTABLE; clearing busy and trying to proceed
[ 1062.752045] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_SET_VIDEO_IN; clearing busy and trying to proceed
[ 1062.784029] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL_ACK; clearing busy and trying to proceed
[ 1062.816027] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.840041] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.864032] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.888051] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.912035] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.936031] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1062.960040] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed

OK. Let's rmmod cx18 and reload it with debug 15 (this will get more
verbose):

[ 1193.934791] cx18: Start initialization, version 1.2.0
[ 1193.934907] cx18-0: Initializing card 0
[ 1193.934913] cx18-0: Autodetected Hauppauge card
[ 1193.943736] cx18-0: info: base addr: 0xc8000000
[ 1193.943742] cx18-0: info: Enabling pci device
[ 1193.943764] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
IRQ 17
[ 1193.943779] cx18-0: info: cx23418 (rev 0) at 00:0e.0, irq: 17,
latency: 64, memory: 0xc8000000
[ 1193.943783] cx18-0: info: attempting ioremap at 0xc8000000 len
0x04000000
[ 1193.947747] cx18-0: cx23418 revision 01010000 (B)
[ 1194.038592] cx18-0: info: GPIO initial dir: 0000cffe/0000ffff out:
00003001/00000000
[ 1194.038617] cx18-0: info: activating i2c...
[ 1194.212312] tveeprom 1-0050: Hauppauge model 74541, rev C6B6, serial#
6314962
[ 1194.212319] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
[ 1194.212323] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
116, type 43)
[ 1194.212327] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
[ 1194.212331] tveeprom 1-0050: audio processor is CX23418 (idx 38)
[ 1194.212334] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
[ 1194.212337] tveeprom 1-0050: has radio
[ 1194.212341] cx18-0: Autodetected Hauppauge HVR-1600
[ 1194.212344] cx18-0: info: NTSC tuner detected
[ 1194.212347] cx18-0: Simultaneous Digital and Analog TV capture
supported
[ 1194.351350] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
[ 1194.351495] tda9887 2-0043: creating new instance
[ 1194.351498] tda9887 2-0043: tda988[5/6/7] found
[ 1194.357625] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
[ 1194.362940] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
[ 1194.365280] tuner-simple 2-0061: creating new instance
[ 1194.365288] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
(FM1236MK3 or FM1236/F))
[ 1194.366682] cx18-0: info: Allocate encoder MPEG stream: 64 x 32768
buffers (2048kB total)
[ 1194.366767] cx18-0: info: Allocate TS stream: 32 x 32768 buffers
(1024kB total)
[ 1194.366804] cx18-0: info: Allocate encoder YUV stream: 16 x 131072
buffers (2048kB total)
[ 1194.366839] cx18-0: info: Allocate encoder VBI stream: 20 x 51984
buffers (1015kB total)
[ 1194.366870] cx18-0: info: Allocate encoder PCM audio stream: 256 x
4096 buffers (1024kB total)
[ 1194.367043] cx18-0: info: Allocate encoder IDX stream: 32 x 32768
buffers (1024kB total)
[ 1194.367362] cx18-0: Registered device video0 for encoder MPEG (64 x
32 kB)
[ 1194.367368] DVB: registering new adapter (cx18)
[ 1194.525014] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-cpu.fw
[ 1194.548213] MXL5005S: Attached at address 0x63
[ 1194.548227] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
QAM/8VSB Frontend)...
[ 1194.567088] cx18-0: DVB Frontend registered
[ 1194.567095] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
[ 1194.567139] cx18-0: Registered device video32 for encoder YUV (16 x
128 kB)
[ 1194.567172] cx18-0: Registered device vbi0 for encoder VBI (20 x
51984 bytes)
[ 1194.567203] cx18-0: Registered device video24 for encoder PCM audio
(256 x 4 kB)
[ 1194.567234] cx18-0: Registered device radio0 for encoder radio
[ 1194.567238] cx18-0: Initialized card: Hauppauge HVR-1600
[ 1194.567277] cx18: End initialization
[ 1194.665016] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332 bytes)
[ 1194.687326] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-apu.fw
[ 1195.204144] cx18-0: info: load segment a00000-a07fff
[ 1195.223682] cx18-0: info: load segment ae0000-ae00ff
[ 1195.223839] cx18-0: info: load segment b00000-b1a65f
[ 1195.288238] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
(141200 bytes)
[ 1195.294223] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
(Release 2007/03/12)
[ 1195.294231] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
[ 1195.684061] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
args 0x00000000
[ 1195.684164] cx18-0: api: CX18_APU_START cmd 0x10000001 args
0x000000b9 0x00000000
[ 1195.685376] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
[ 1195.704063] cx18-0: warning: sending CX18_APU_RESETAI timed out
waiting 20 msecs for RPU acknowledgement
[ 1195.704074] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
0x00000000
[ 1195.716054] cx18-0: mbox was found stuck busy when setting up for
CX18_APU_STOP; clearing busy and trying to proceed
[ 1195.736058] cx18-0: warning: sending CX18_APU_STOP timed out waiting
20 msecs for RPU acknowledgement
[ 1195.740130] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-cpu.fw
[ 1195.906342] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-apu.fw
[ 1196.034837] cx18-0: info: load segment a00000-a07fff
[ 1196.054586] cx18-0: info: load segment ae0000-ae00ff
[ 1196.054744] cx18-0: info: load segment b00000-b1a65f
[ 1196.125354] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
(Release 2007/03/12)
[ 1196.416058] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
args 0x00000000
[ 1196.416198] cx18-0: api: CX18_APU_START cmd 0x10000001 args
0x000000b9 0x00000000
[ 1196.417406] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
[ 1196.417841] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
0x00000000
[ 1196.417925] cx18 0000:00:0e.0: firmware: requesting
v4l-cx23418-dig.fw
[ 1196.629074] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
bytes)
[ 1196.646410] cx18-0 843: verified load of v4l-cx23418-dig.fw firmware
(16382 bytes)
[ 1196.646511] cx18-0: info: Changing input from 1 to 0
[ 1196.646514] cx18-0: info: Mute
[ 1196.646518] cx18-0 843: info: decoder set video input 7, audio input
8
[ 1196.874385] cx18-0 843: info: decoder set video input 7, audio input
8
[ 1196.874466] cx18-0: info: Unmute
[ 1196.874471] cx18-0: info: Switching standard to 1000.
[ 1196.874475] cx18-0 843: info: changing video std to fmt 1
[ 1196.874491] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
post: 4
[ 1196.874495] cx18-0 843: info: Video PLL = 107.999999 MHz
[ 1196.874498] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
[ 1196.874501] cx18-0 843: info: ADC XTAL/pixel clock decimation ratio
= 2.121
[ 1196.874505] cx18-0 843: info: Chroma sub-carrier initial freq =
3.579545 MHz
[ 1196.874510] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
1, comb 0x66, sc 0x087c00
[ 1196.876084] cx18-0: info: Mute
[ 1196.876088] cx18-0: info: v4l2 ioctl: set frequency 1076
[ 1196.880431] cx18-0: info: Unmute
[ 1196.883681] cx18-0: info: Mute
[ 1196.885911] cx18-0 843: info: decoder set video input 7, audio input
0
[ 1196.885976] cx18-0: info: Unmute
[ 1196.907271] cx18-0: info: Mute
[ 1196.907281] cx18-0 843: info: changing video std to fmt 1
[ 1196.907298] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
post: 4
[ 1196.907301] cx18-0 843: info: Video PLL = 107.999999 MHz
[ 1196.907304] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
[ 1196.907307] cx18-0 843: info: ADC XTAL/pixel clock decimation ratio
= 2.121
[ 1196.907311] cx18-0 843: info: Chroma sub-carrier initial freq =
3.579545 MHz
[ 1196.907316] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
1, comb 0x66, sc 0x087c00
[ 1196.910267] cx18-0 843: info: decoder set video input 7, audio input
8
[ 1196.910337] cx18-0: info: Unmute
[ 1196.932515] cx18-0: info: Input unchanged
[ 1196.932528] cx18-0: info: Switching standard to b000.
[ 1196.932533] cx18-0 843: info: changing video std to fmt 1
[ 1196.932550] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
post: 4
[ 1196.932554] cx18-0 843: info: Video PLL = 107.999999 MHz
[ 1196.932557] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
[ 1196.932560] cx18-0 843: info: ADC XTAL/pixel clock decimation ratio
= 2.121
[ 1196.932563] cx18-0 843: info: Chroma sub-carrier initial freq =
3.579545 MHz
[ 1196.932568] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
1, comb 0x66, sc 0x087c00
[ 1196.935640] cx18-0: info: Input unchanged
[ 1196.939236] cx18-0: info: Mute
[ 1196.939245] cx18-0: info: v4l2 ioctl: set frequency 2996
[ 1196.941995] cx18-0: info: Unmute

Now try watching tv in MythTV again. Works (no sound)

[ 1287.648309] cx18-0: info: Start feed: pid = 0x0 index = 0
[ 1287.648320] cx18-0: info: Starting Transport DMA
[ 1287.648324] cx18-0: info: Start encoder stream TS
[ 1287.648331] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
0x20020000
[ 1287.648568] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
args 0x00000000 0x00000007
[ 1287.648755] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
args 0x00000000 0x00dc0c50 0x00dc0c58
[ 1287.656157] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
args 0x00000000
[ 1287.956156] cx18-0: info: Stop feed: pid = 0x0 index = 0
[ 1287.956164] cx18-0: info: Stopping Transport DMA
[ 1287.956167] cx18-0: info: Stop Capture
[ 1287.956172] cx18-0: api: CX18_CPU_CAPTURE_STOP cmd 0x20020003
args 0x00000000
[ 1288.256042] cx18-0: api: CX18_CPU_DE_RELEASE_MDL cmd 0x20040006
args 0x00000000
[ 1288.556032] cx18-0: api: CX18_DESTROY_TASK cmd 0x40000002 args
0x00000000
[ 1288.565268] cx18-0: info: Start feed: pid = 0x0 index = 0
[ 1288.565280] cx18-0: info: Starting Transport DMA
[ 1288.565284] cx18-0: info: Start encoder stream TS
[ 1288.565290] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
0x20020000
[ 1288.565359] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
args 0x00000000 0x00000007
[ 1288.565411] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
args 0x00000000 0x00dc0c50 0x00dc0c58
[ 1288.567396] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
args 0x00000000
[ 1288.864322] cx18-0: info: Start feed: pid = 0x1ffb index = 1
[ 1288.947032] cx18-0: info: Start feed: pid = 0x30 index = 2
[ 1288.986940] cx18-0: info: Start feed: pid = 0x31 index = 3
[ 1288.987026] cx18-0: info: Start feed: pid = 0x34 index = 4
[ 1289.027432] cx18-0: info: Start feed: pid = 0x1388 index = 5
[ 1289.027517] cx18-0: info: Start feed: pid = 0x1389 index = 6
[ 1289.027573] cx18-0: info: Start feed: pid = 0x138a index = 7
[ 1289.027627] cx18-0: info: Start feed: pid = 0x138b index = 8
[ 1289.027680] cx18-0: info: Start feed: pid = 0x1408 index = 9
[ 1289.027733] cx18-0: info: Start feed: pid = 0x1409 index = 10
[ 1289.027786] cx18-0: info: Start feed: pid = 0x140a index = 11
[ 1289.027840] cx18-0: info: Start feed: pid = 0x140b index = 12
[ 1343.893201] cx18-0: warning: failed to be awakened upon RPU
acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
[ 1393.845930] cx18-0: warning: failed to be awakened upon RPU
acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
[ 1437.591889] cx18-0: info: Input unchanged
[ 1437.595203] cx18-0: info: Mute
[ 1437.595211] cx18-0: info: v4l2 ioctl: set frequency 2996
[ 1437.597791] cx18-0: info: Unmute
[ 1438.785345] cx18-0 843: info: decoder set size 480x480 -> scale
524288x0
[ 1438.785773] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
0x20020011 args 0xffffffff 0x000000ba
[ 1438.785915] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.785974] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.786028] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.786178] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.786231] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.786284] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.786379] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.786433] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.786486] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.786574] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
0x20020011 args 0xffffffff 0x000000ea
[ 1438.786632] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.786686] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.786738] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.786827] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
args 0xffffffff 0x00000000 0x005b8d80 0x00003a98 0x00000000
[ 1438.786892] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.786954] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.787021] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.787507] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
args 0xffffffff 0x00000000 0x0044aa20 0x00003a98 0x00000000
[ 1438.787714] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.787773] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.787829] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.787922] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000001 0x00000000 0x00000000
[ 1438.787978] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000000 0x00000000 0x00000000
[ 1438.793941] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0xffffffff 0x00000002 0x00000000 0x00000000
[ 1438.794952] cx18-0: info: Start encoder stream encoder MPEG
[ 1438.794959] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
0x20020000
[ 1438.795078] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
args 0x00000001 0x00000001
[ 1438.795206] cx18-0: api: CX18_CPU_SET_VER_CROP_LINE cmd 0x2002001b
args 0x00000001 0x00000000
[ 1438.795261] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x00000003 0x00000001
[ 1438.795317] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x00000008 0x00000000
[ 1438.795413] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x00000004 0x00000001
[ 1438.795544] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x0000000c
[ 1438.795596] cx18-0: api: CX18_CPU_SET_CAPTURE_LINE_NO cmd
0x20020017 args 0x00000001 0x00000138 0x00000139
[ 1438.795680] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
post: 4
[ 1438.795684] cx18-0 843: info: Video PLL = 107.999999 MHz
[ 1438.795688] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
[ 1438.795691] cx18-0 843: info: ADC XTAL/pixel clock decimation ratio
= 2.121
[ 1438.795694] cx18-0 843: info: Chroma sub-carrier initial freq =
3.579545 MHz
[ 1438.795700] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
1, comb 0x66, sc 0x087c00
[ 1438.795747] cx18-0: info: Setup VBI h: 1 lines c000c bpl 1444 fr 1
20602060 307090d0
[ 1438.795753] cx18-0: api: CX18_CPU_SET_RAW_VBI_PARAM cmd 0x20020016
args 0x00000001 0x000c000c 0x000005a4 0x00000001 0x20602060 0x307090d0
[ 1439.092027] cx18-0: api: CX18_CPU_SET_INDEXTABLE cmd 0x20020010
args 0x00000000
[ 1439.092089] cx18-0: api: CX18_CPU_SET_VIDEO_IN cmd 0x20020004
args 0x00000001 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000
[ 1439.092163] cx18-0: api: CX18_CPU_SET_VIDEO_RESOLUTION cmd
0x20020006 args 0x00000001 0x000001e0 0x000001e0
[ 1439.092735] cx18-0: api: CX18_CPU_SET_STREAM_OUTPUT_TYPE cmd
0x20020012 args 0x00000001 0x00000000
[ 1439.092796] cx18-0: api: CX18_CPU_SET_ASPECT_RATIO cmd 0x2002001e
args 0x00000001 0x00000002
[ 1439.092850] cx18-0: api: CX18_CPU_SET_GOP_STRUCTURE cmd 0x2002001c
args 0x00000001 0x0000000f 0x00000003
[ 1439.092901] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
0x20020011 args 0x00000001 0x000000ea
[ 1439.092964] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
args 0x00000001 0x00000000
[ 1439.093028] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
args 0x00000001 0x00000000 0x0044aa20 0x00003a98 0x00000000
[ 1439.093087] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000001 0x00000000 0x00000000
[ 1439.093142] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000000 0x00000000 0x00000000
[ 1439.093196] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000002 0x00000000 0x00000000
[ 1439.093251] cx18-0: api: CX18_CPU_SET_MEDIAN_CORING cmd 0x2002000e
args 0x00000001 0x00000000 0x000000ff 0x00000000 0x000000ff
[ 1439.093311] cx18-0: api: CX18_CPU_SET_SPATIAL_FILTER_TYPE cmd
0x2002000c args 0x00000001 0x00000001 0x00000001
[ 1439.093368] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000001 0x00000000 0x00000000
[ 1439.093466] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000000 0x00000000 0x00000000
[ 1439.093530] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
args 0x00000001 0x00000002 0x00000000 0x00000000
[ 1439.093584] cx18-0: api: CX18_CPU_SET_SKIP_INPUT_FRAME cmd
0x2002001f args 0x00000001 0x00000000
[ 1439.093633] cx18-0: api: CX18_CPU_SET_VIDEO_MUTE cmd 0x20020013
args 0x00000001 0x00808000
[ 1439.093684] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x00000007 0x00000000 0x00000000
[ 1439.093739] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
args 0x00000001 0x00dc0c40 0x00dc0c48
[ 1439.102576] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
args 0x00000001
[ 1446.654744] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 11990)
[ 1446.654757] cx18-0: api: incoming: req 0x00002ed6 ack 0x00002ed6 cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
0x00000000 0x00000000 0x00000000
[ 1460.770887] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13494) while
processing
[ 1462.271840] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13655)
[ 1462.271852] cx18-0: api: incoming: req 0x00003557 ack 0x00003557 cmd
0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
0x00000000 0x00000000 0x00000000
[ 1468.290206] cx18-0: warning: failed to be awakened upon RPU
acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 20 msecs
[ 1473.784866] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 14887) while
processing
[ 1482.287056] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 15789)
[ 1482.287067] cx18-0: api: incoming: req 0x00003dad ack 0x00003dad cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
0x00000000 0x00000000 0x00000000
[ 1488.798573] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 16485)
[ 1488.798585] cx18-0: api: incoming: req 0x00004065 ack 0x00004065 cmd
0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
0x00000000 0x00000000 0x00000000
[ 1507.416354] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18463)
[ 1507.416365] cx18-0: api: incoming: req 0x0000481f ack 0x0000481f cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
0x00000000 0x00000000 0x00000000
[ 1510.620047] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18802) while
processing
[ 1514.322277] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 19202) while
processing
[ 1535.844227] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 21490)
[ 1535.844239] cx18-0: api: incoming: req 0x000053f2 ack 0x000053f2 cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
0x00000000 0x00000000 0x00000000
[ 1542.453566] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 22194)
[ 1542.453577] cx18-0: api: incoming: req 0x000056b2 ack 0x000056b2 cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
0x00000000 0x00000000 0x00000000
[ 1558.067669] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 23843)
[ 1558.067680] cx18-0: api: incoming: req 0x00005d23 ack 0x00005d23 cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
0x00000000 0x00000000 0x00000000
[ 1565.474276] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 24628)
[ 1565.474288] cx18-0: api: incoming: req 0x00006034 ack 0x00006034 cmd
0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
0x00000000 0x00000000 0x00000000
[ 1573.382111] cx18-0: warning: Possibly falling behind: CPU
self-ack'ed our incoming CPU to EPU mailbox (sequence no. 25465) while
processing

Let's change the channel again. Playback stops. log:

[ 1696.430026] cx18-0: info: Input unchanged
[ 1696.433796] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
args 0x00000001 0x00000001
[ 1696.435486] cx18-0: info: Mute
[ 1696.435491] cx18-0: info: v4l2 ioctl: set frequency 3092
[ 1696.536031] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
0x20020015 args 0x00000001 0x0000000c
[ 1696.536109] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
args 0x00000001 0x00000000
[ 1696.556037] cx18-0: warning: sending CX18_CPU_SET_AUDIO_MUTE timed
out waiting 20 msecs for RPU acknowledgement
[ 1696.556045] cx18-0: info: Unmute
[ 1697.929472] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1697.940101] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement
[ 1697.952041] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1697.964776] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement
[ 1697.976055] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1697.988026] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement
[ 1698.000042] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1698.012028] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement
[ 1698.024027] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1698.036038] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement
[ 1698.048035] cx18-0: mbox was found stuck busy when setting up for
CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
[ 1698.060025] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
waiting 12 msecs for RPU acknowledgement

If I only enable the DVB tuner in MythTV and start up that way, I can
have digital tv just fine. Sound works for the digital channels too.
However, if I enable both analog and digital tuners and get into the
above error situation by trying to change a station on the analog tuner,
digital channels will not work after that anymore.

Please advise. Any help will be appreciated.


Thank you,

Michiel van Wessem
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
awalls at radix
Oct 25, 2009, 4:39 PM
Post #2 of 9 (5340 views)
Permalink
On Sun, 2009-10-25 at 10:38 -0400, Jacob Michael van Wessem wrote:
> Hello,
>
> I'm having some problems with the Hauppage WinTV-HVR-1600 that I
> recently bought. I'm running Jaunty on a system with an ASUS A7V333
> motherboard with BIOS version 1017, AMD Athlon XP 1800+ and nVideo
> GeForce 7600 GT video card with 256mb ram. The WinTV-HVR-1600 is the
> kind with the MCE remote. Current kernel is labeled 2.6.28-16-generic
> #55-Ubuntu SMP and I installed the
> cx-18 module as per http://www.mythtv.org/wiki/Hauppauge_HVR-1600
>
> I'm having two problems:
>
> - Analog video has no sound.
> - Changing the channel on the analog tuner stops playback and seems to
> lock up all use of the WinTV-HVR-1600
>
> I hope you guys can help me resolve these problems.
>
> Here is a typical session:
>
> System startup:
>
> [ 14.927186] cx18: Start initialization, version 1.2.0
> [ 14.927973] cx18-0: Initializing card 0
> [ 14.927983] cx18-0: Autodetected Hauppauge card
> [ 14.937864] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
> IRQ 17
> [ 14.937975] cx18-0: Unreasonably low latency timer, setting to 64
> (was 32)
> [ 14.943431] cx18-0: cx23418 revision 01010000 (B)
> [ 15.234170] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> serial# 6314962
> [ 15.234179] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> [ 15.234184] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> 116, type 43)
> [ 15.234190] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> [ 15.234195] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> [ 15.234199] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> [ 15.234203] tveeprom 1-0050: has radio
> [ 15.234207] cx18-0: Autodetected Hauppauge HVR-1600
> [ 15.234213] cx18-0: Simultaneous Digital and Analog TV capture
> supported
> [ 15.421386] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> [ 15.440345] tda9887 2-0043: creating new instance
> [ 15.440354] tda9887 2-0043: tda988[5/6/7] found
> [ 15.446498] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> [ 15.467427] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> [ 15.491851] tuner-simple 2-0061: creating new instance
> [ 15.491862] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> (FM1236MK3 or FM1236/F))
> [ 15.494124] cx18-0: Registered device video0 for encoder MPEG (64 x
> 32 kB)
> [ 15.494132] DVB: registering new adapter (cx18)
> [ 15.612500] MXL5005S: Attached at address 0x63
> [ 15.612516] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> QAM/8VSB Frontend)...
> [ 15.612934] cx18-0: DVB Frontend registered
> [ 15.612941] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> [ 15.613067] cx18-0: Registered device video32 for encoder YUV (16 x
> 128 kB)
> [ 15.613238] cx18-0: Registered device vbi0 for encoder VBI (20 x
> 51984 bytes)
> [ 15.613341] cx18-0: Registered device video24 for encoder PCM audio
> (256 x 4 kB)
> [ 15.613438] cx18-0: Registered device radio0 for encoder radio
> [ 15.613444] cx18-0: Initialized card: Hauppauge HVR-1600
> [ 15.613539] cx18: End initialization
> [ 15.678354] C-Media PCI 0000:00:05.0: PCI INT A -> GSI 17 (level,
> low) -> IRQ 17
> [ 22.928450] ivtv: Start initialization, version 1.4.1
> [ 22.928559] ivtv: End initialization
> [ 22.945289] lirc_pvr150: disagrees about version of symbol
> ivtv_reset_ir_gpio
> [ 22.945302] lirc_pvr150: Unknown symbol ivtv_reset_ir_gpio
> [ 30.604990] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-cpu.fw
> [ 30.771584] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> bytes)
> [ 30.795006] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-apu.fw
> [ 30.964545] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> (141200 bytes)
> [ 30.973159] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> [ 31.300412] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-cpu.fw
> [ 31.462333] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-apu.fw
> [ 31.801713] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-dig.fw
> [ 31.991741] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> bytes)
> [ 32.009660] cx18-0 843: verified load of v4l-cx23418-dig.fw
> firmware (16382 bytes)
>
> It's not clear to me why driver reports that firmware is requesting
> apu and cpu again after reporting that they are loaded.

That's normal. It's loaded twice to get around a firmware bug with
digital TV.


> I think the C-Media PCI line is for the onboard sound, not the
> HVR-1600, but I've left it in here because it's sharing interrupt 17
> with cx-18. cat /proc/interrupts:
>
> 17: 57174 IO-APIC-fasteoi ehci_hcd:usb1, cx18-0, CMI8738-MC6
>
> Is it possible that this interrupt sharing causes the lockups and lack
> of sound?

Your problem doewsn't look like it is related to the CX23418's interrupt
being held off too long. So maybe, but not likely.



> Alright. Start MythTV, go to watch TV. Analog playback starts, but
> there is no audio. Nothing in kernel log.
>
> Now change the channel in MythTV. Playback stops indefinitely. Kernel
> log shows this:
> [ 1057.324029] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1057.348043] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1057.372025] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.332033] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_CAPTURE_STOP; clearing busy and trying to proceed
> [ 1062.364024] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_RELEASE_MDL; clearing busy and trying to proceed
> [ 1062.396025] cx18-0: mbox was found stuck busy when setting up for
> CX18_DESTROY_TASK; clearing busy and trying to proceed
> [ 1062.428038] cx18-0: mbox was found stuck busy when setting up for
> CX18_CREATE_TASK; clearing busy and trying to proceed
> [ 1062.467782] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_CHANNEL_TYPE; clearing busy and trying to proceed
> [ 1062.496033] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_VER_CROP_LINE; clearing busy and trying to proceed
> [ 1062.528036] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> [ 1062.560034] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> [ 1062.592040] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> [ 1062.624030] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> [ 1062.656039] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_CAPTURE_LINE_NO; clearing busy and trying to proceed
> [ 1062.688175] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_RAW_VBI_PARAM; clearing busy and trying to proceed
> [ 1062.720046] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_INDEXTABLE; clearing busy and trying to proceed
> [ 1062.752045] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_SET_VIDEO_IN; clearing busy and trying to proceed
> [ 1062.784029] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL_ACK; clearing busy and trying to proceed
> [ 1062.816027] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.840041] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.864032] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.888051] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.912035] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.936031] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1062.960040] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed

This is a bad condition. I've never seen it happen before; I just put
the log message in there in case it did one day. Repeated "stuck busy"
messages indicate the CX23418 has gone "stupid" or is not responding
properly.


> OK. Let's rmmod cx18 and reload it with debug 15 (this will get more
> verbose):
>
> [ 1193.934791] cx18: Start initialization, version 1.2.0
> [ 1193.934907] cx18-0: Initializing card 0
> [ 1193.934913] cx18-0: Autodetected Hauppauge card
> [ 1193.943736] cx18-0: info: base addr: 0xc8000000
> [ 1193.943742] cx18-0: info: Enabling pci device
> [ 1193.943764] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
> IRQ 17
> [ 1193.943779] cx18-0: info: cx23418 (rev 0) at 00:0e.0, irq: 17,
> latency: 64, memory: 0xc8000000
> [ 1193.943783] cx18-0: info: attempting ioremap at 0xc8000000 len
> 0x04000000
> [ 1193.947747] cx18-0: cx23418 revision 01010000 (B)
> [ 1194.038592] cx18-0: info: GPIO initial dir: 0000cffe/0000ffff out:
> 00003001/00000000
> [ 1194.038617] cx18-0: info: activating i2c...
> [ 1194.212312] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> serial# 6314962
> [ 1194.212319] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> [ 1194.212323] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> 116, type 43)
> [ 1194.212327] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> [ 1194.212331] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> [ 1194.212334] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> [ 1194.212337] tveeprom 1-0050: has radio
> [ 1194.212341] cx18-0: Autodetected Hauppauge HVR-1600
> [ 1194.212344] cx18-0: info: NTSC tuner detected
> [ 1194.212347] cx18-0: Simultaneous Digital and Analog TV capture
> supported
> [ 1194.351350] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> [ 1194.351495] tda9887 2-0043: creating new instance
> [ 1194.351498] tda9887 2-0043: tda988[5/6/7] found
> [ 1194.357625] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> [ 1194.362940] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> [ 1194.365280] tuner-simple 2-0061: creating new instance
> [ 1194.365288] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> (FM1236MK3 or FM1236/F))
> [ 1194.366682] cx18-0: info: Allocate encoder MPEG stream: 64 x 32768
> buffers (2048kB total)
> [ 1194.366767] cx18-0: info: Allocate TS stream: 32 x 32768 buffers
> (1024kB total)
> [ 1194.366804] cx18-0: info: Allocate encoder YUV stream: 16 x 131072
> buffers (2048kB total)
> [ 1194.366839] cx18-0: info: Allocate encoder VBI stream: 20 x 51984
> buffers (1015kB total)
> [ 1194.366870] cx18-0: info: Allocate encoder PCM audio stream: 256 x
> 4096 buffers (1024kB total)
> [ 1194.367043] cx18-0: info: Allocate encoder IDX stream: 32 x 32768
> buffers (1024kB total)
> [ 1194.367362] cx18-0: Registered device video0 for encoder MPEG (64 x
> 32 kB)
> [ 1194.367368] DVB: registering new adapter (cx18)
> [ 1194.525014] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-cpu.fw
> [ 1194.548213] MXL5005S: Attached at address 0x63
> [ 1194.548227] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> QAM/8VSB Frontend)...
> [ 1194.567088] cx18-0: DVB Frontend registered
> [ 1194.567095] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> [ 1194.567139] cx18-0: Registered device video32 for encoder YUV (16 x
> 128 kB)
> [ 1194.567172] cx18-0: Registered device vbi0 for encoder VBI (20 x
> 51984 bytes)
> [ 1194.567203] cx18-0: Registered device video24 for encoder PCM audio
> (256 x 4 kB)
> [ 1194.567234] cx18-0: Registered device radio0 for encoder radio
> [ 1194.567238] cx18-0: Initialized card: Hauppauge HVR-1600
> [ 1194.567277] cx18: End initialization
> [ 1194.665016] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> bytes)
> [ 1194.687326] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-apu.fw
> [ 1195.204144] cx18-0: info: load segment a00000-a07fff
> [ 1195.223682] cx18-0: info: load segment ae0000-ae00ff
> [ 1195.223839] cx18-0: info: load segment b00000-b1a65f
> [ 1195.288238] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> (141200 bytes)
> [ 1195.294223] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> (Release 2007/03/12)
> [ 1195.294231] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> [ 1195.684061] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> args 0x00000000
> [ 1195.684164] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> 0x000000b9 0x00000000
> [ 1195.685376] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> [ 1195.704063] cx18-0: warning: sending CX18_APU_RESETAI timed out
> waiting 20 msecs for RPU acknowledgement
> [ 1195.704074] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> 0x00000000
> [ 1195.716054] cx18-0: mbox was found stuck busy when setting up for
> CX18_APU_STOP; clearing busy and trying to proceed
> [ 1195.736058] cx18-0: warning: sending CX18_APU_STOP timed out
> waiting 20 msecs for RPU acknowledgement

This shouldn't be happening. Something is wrong with your PCI bus, or
your power, or your APU or CPU firmware image. Or you have a bad
CX23418. The APU (audio processing unit) should respond and pick up its
mail almost immediately, and not leave the APU's incoming mailbox busy
(full).



> [ 1195.740130] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-cpu.fw
> [ 1195.906342] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-apu.fw
> [ 1196.034837] cx18-0: info: load segment a00000-a07fff
> [ 1196.054586] cx18-0: info: load segment ae0000-ae00ff
> [ 1196.054744] cx18-0: info: load segment b00000-b1a65f
> [ 1196.125354] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> (Release 2007/03/12)
> [ 1196.416058] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> args 0x00000000
> [ 1196.416198] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> 0x000000b9 0x00000000
> [ 1196.417406] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> [ 1196.417841] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> 0x00000000
> [ 1196.417925] cx18 0000:00:0e.0: firmware: requesting
> v4l-cx23418-dig.fw
> [ 1196.629074] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> bytes)
> [ 1196.646410] cx18-0 843: verified load of v4l-cx23418-dig.fw
> firmware (16382 bytes)
> [ 1196.646511] cx18-0: info: Changing input from 1 to 0
> [ 1196.646514] cx18-0: info: Mute
> [ 1196.646518] cx18-0 843: info: decoder set video input 7, audio
> input 8
> [ 1196.874385] cx18-0 843: info: decoder set video input 7, audio
> input 8
> [ 1196.874466] cx18-0: info: Unmute
> [ 1196.874471] cx18-0: info: Switching standard to 1000.
> [ 1196.874475] cx18-0 843: info: changing video std to fmt 1
> [ 1196.874491] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> post: 4
> [ 1196.874495] cx18-0 843: info: Video PLL = 107.999999 MHz
> [ 1196.874498] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> [ 1196.874501] cx18-0 843: info: ADC XTAL/pixel clock decimation
> ratio = 2.121
> [ 1196.874505] cx18-0 843: info: Chroma sub-carrier initial freq =
> 3.579545 MHz
> [ 1196.874510] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> 1, comb 0x66, sc 0x087c00
> [ 1196.876084] cx18-0: info: Mute
> [ 1196.876088] cx18-0: info: v4l2 ioctl: set frequency 1076
> [ 1196.880431] cx18-0: info: Unmute
> [ 1196.883681] cx18-0: info: Mute
> [ 1196.885911] cx18-0 843: info: decoder set video input 7, audio
> input 0
> [ 1196.885976] cx18-0: info: Unmute
> [ 1196.907271] cx18-0: info: Mute
> [ 1196.907281] cx18-0 843: info: changing video std to fmt 1
> [ 1196.907298] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> post: 4
> [ 1196.907301] cx18-0 843: info: Video PLL = 107.999999 MHz
> [ 1196.907304] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> [ 1196.907307] cx18-0 843: info: ADC XTAL/pixel clock decimation
> ratio = 2.121
> [ 1196.907311] cx18-0 843: info: Chroma sub-carrier initial freq =
> 3.579545 MHz
> [ 1196.907316] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> 1, comb 0x66, sc 0x087c00
> [ 1196.910267] cx18-0 843: info: decoder set video input 7, audio
> input 8
> [ 1196.910337] cx18-0: info: Unmute
> [ 1196.932515] cx18-0: info: Input unchanged
> [ 1196.932528] cx18-0: info: Switching standard to b000.
> [ 1196.932533] cx18-0 843: info: changing video std to fmt 1
> [ 1196.932550] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> post: 4
> [ 1196.932554] cx18-0 843: info: Video PLL = 107.999999 MHz
> [ 1196.932557] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> [ 1196.932560] cx18-0 843: info: ADC XTAL/pixel clock decimation
> ratio = 2.121
> [ 1196.932563] cx18-0 843: info: Chroma sub-carrier initial freq =
> 3.579545 MHz
> [ 1196.932568] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> 1, comb 0x66, sc 0x087c00
> [ 1196.935640] cx18-0: info: Input unchanged
> [ 1196.939236] cx18-0: info: Mute
> [ 1196.939245] cx18-0: info: v4l2 ioctl: set frequency 2996
> [ 1196.941995] cx18-0: info: Unmute
>
> Now try watching tv in MythTV again. Works (no sound)
>
> [ 1287.648309] cx18-0: info: Start feed: pid = 0x0 index = 0
> [ 1287.648320] cx18-0: info: Starting Transport DMA
> [ 1287.648324] cx18-0: info: Start encoder stream TS
> [ 1287.648331] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> 0x20020000
> [ 1287.648568] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> args 0x00000000 0x00000007
> [ 1287.648755] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> args 0x00000000 0x00dc0c50 0x00dc0c58
> [ 1287.656157] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> args 0x00000000
> [ 1287.956156] cx18-0: info: Stop feed: pid = 0x0 index = 0
> [ 1287.956164] cx18-0: info: Stopping Transport DMA
> [ 1287.956167] cx18-0: info: Stop Capture
> [ 1287.956172] cx18-0: api: CX18_CPU_CAPTURE_STOP cmd 0x20020003
> args 0x00000000
> [ 1288.256042] cx18-0: api: CX18_CPU_DE_RELEASE_MDL cmd 0x20040006
> args 0x00000000
> [ 1288.556032] cx18-0: api: CX18_DESTROY_TASK cmd 0x40000002 args
> 0x00000000
> [ 1288.565268] cx18-0: info: Start feed: pid = 0x0 index = 0
> [ 1288.565280] cx18-0: info: Starting Transport DMA
> [ 1288.565284] cx18-0: info: Start encoder stream TS
> [ 1288.565290] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> 0x20020000
> [ 1288.565359] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> args 0x00000000 0x00000007
> [ 1288.565411] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> args 0x00000000 0x00dc0c50 0x00dc0c58
> [ 1288.567396] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> args 0x00000000
> [ 1288.864322] cx18-0: info: Start feed: pid = 0x1ffb index = 1
> [ 1288.947032] cx18-0: info: Start feed: pid = 0x30 index = 2
> [ 1288.986940] cx18-0: info: Start feed: pid = 0x31 index = 3
> [ 1288.987026] cx18-0: info: Start feed: pid = 0x34 index = 4
> [ 1289.027432] cx18-0: info: Start feed: pid = 0x1388 index = 5
> [ 1289.027517] cx18-0: info: Start feed: pid = 0x1389 index = 6
> [ 1289.027573] cx18-0: info: Start feed: pid = 0x138a index = 7
> [ 1289.027627] cx18-0: info: Start feed: pid = 0x138b index = 8
> [ 1289.027680] cx18-0: info: Start feed: pid = 0x1408 index = 9
> [ 1289.027733] cx18-0: info: Start feed: pid = 0x1409 index = 10
> [ 1289.027786] cx18-0: info: Start feed: pid = 0x140a index = 11
> [ 1289.027840] cx18-0: info: Start feed: pid = 0x140b index = 12
> [ 1343.893201] cx18-0: warning: failed to be awakened upon RPU
> acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> [ 1393.845930] cx18-0: warning: failed to be awakened upon RPU
> acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> [ 1437.591889] cx18-0: info: Input unchanged
> [ 1437.595203] cx18-0: info: Mute
> [ 1437.595211] cx18-0: info: v4l2 ioctl: set frequency 2996
> [ 1437.597791] cx18-0: info: Unmute
> [ 1438.785345] cx18-0 843: info: decoder set size 480x480 -> scale
> 524288x0
> [ 1438.785773] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> 0x20020011 args 0xffffffff 0x000000ba
> [ 1438.785915] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.785974] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.786028] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.786178] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.786231] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.786284] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.786379] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.786433] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.786486] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.786574] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> 0x20020011 args 0xffffffff 0x000000ea
> [ 1438.786632] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.786686] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.786738] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.786827] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> args 0xffffffff 0x00000000 0x005b8d80 0x00003a98 0x00000000
> [ 1438.786892] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.786954] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.787021] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.787507] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> args 0xffffffff 0x00000000 0x0044aa20 0x00003a98 0x00000000
> [ 1438.787714] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.787773] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.787829] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.787922] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000001 0x00000000 0x00000000
> [ 1438.787978] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000000 0x00000000 0x00000000
> [ 1438.793941] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0xffffffff 0x00000002 0x00000000 0x00000000
> [ 1438.794952] cx18-0: info: Start encoder stream encoder MPEG
> [ 1438.794959] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> 0x20020000
> [ 1438.795078] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> args 0x00000001 0x00000001
> [ 1438.795206] cx18-0: api: CX18_CPU_SET_VER_CROP_LINE cmd 0x2002001b
> args 0x00000001 0x00000000
> [ 1438.795261] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x00000003 0x00000001
> [ 1438.795317] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x00000008 0x00000000
> [ 1438.795413] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x00000004 0x00000001
> [ 1438.795544] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x0000000c
> [ 1438.795596] cx18-0: api: CX18_CPU_SET_CAPTURE_LINE_NO cmd
> 0x20020017 args 0x00000001 0x00000138 0x00000139
> [ 1438.795680] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> post: 4
> [ 1438.795684] cx18-0 843: info: Video PLL = 107.999999 MHz
> [ 1438.795688] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> [ 1438.795691] cx18-0 843: info: ADC XTAL/pixel clock decimation
> ratio = 2.121
> [ 1438.795694] cx18-0 843: info: Chroma sub-carrier initial freq =
> 3.579545 MHz
> [ 1438.795700] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> 1, comb 0x66, sc 0x087c00
> [ 1438.795747] cx18-0: info: Setup VBI h: 1 lines c000c bpl 1444 fr 1
> 20602060 307090d0
> [ 1438.795753] cx18-0: api: CX18_CPU_SET_RAW_VBI_PARAM cmd 0x20020016
> args 0x00000001 0x000c000c 0x000005a4 0x00000001 0x20602060 0x307090d0
> [ 1439.092027] cx18-0: api: CX18_CPU_SET_INDEXTABLE cmd 0x20020010
> args 0x00000000
> [ 1439.092089] cx18-0: api: CX18_CPU_SET_VIDEO_IN cmd 0x20020004
> args 0x00000001 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000
> [ 1439.092163] cx18-0: api: CX18_CPU_SET_VIDEO_RESOLUTION cmd
> 0x20020006 args 0x00000001 0x000001e0 0x000001e0
> [ 1439.092735] cx18-0: api: CX18_CPU_SET_STREAM_OUTPUT_TYPE cmd
> 0x20020012 args 0x00000001 0x00000000
> [ 1439.092796] cx18-0: api: CX18_CPU_SET_ASPECT_RATIO cmd 0x2002001e
> args 0x00000001 0x00000002
> [ 1439.092850] cx18-0: api: CX18_CPU_SET_GOP_STRUCTURE cmd 0x2002001c
> args 0x00000001 0x0000000f 0x00000003
> [ 1439.092901] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> 0x20020011 args 0x00000001 0x000000ea
> [ 1439.092964] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> args 0x00000001 0x00000000
> [ 1439.093028] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> args 0x00000001 0x00000000 0x0044aa20 0x00003a98 0x00000000
> [ 1439.093087] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000001 0x00000000 0x00000000
> [ 1439.093142] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000000 0x00000000 0x00000000
> [ 1439.093196] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000002 0x00000000 0x00000000
> [ 1439.093251] cx18-0: api: CX18_CPU_SET_MEDIAN_CORING cmd 0x2002000e
> args 0x00000001 0x00000000 0x000000ff 0x00000000 0x000000ff
> [ 1439.093311] cx18-0: api: CX18_CPU_SET_SPATIAL_FILTER_TYPE cmd
> 0x2002000c args 0x00000001 0x00000001 0x00000001
> [ 1439.093368] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000001 0x00000000 0x00000000
> [ 1439.093466] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000000 0x00000000 0x00000000
> [ 1439.093530] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> args 0x00000001 0x00000002 0x00000000 0x00000000
> [ 1439.093584] cx18-0: api: CX18_CPU_SET_SKIP_INPUT_FRAME cmd
> 0x2002001f args 0x00000001 0x00000000
> [ 1439.093633] cx18-0: api: CX18_CPU_SET_VIDEO_MUTE cmd 0x20020013
> args 0x00000001 0x00808000
> [ 1439.093684] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x00000007 0x00000000 0x00000000
> [ 1439.093739] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> args 0x00000001 0x00dc0c40 0x00dc0c48
> [ 1439.102576] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> args 0x00000001
> [ 1446.654744] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 11990)
> [ 1446.654757] cx18-0: api: incoming: req 0x00002ed6 ack 0x00002ed6
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1460.770887] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13494) while
> processing
> [ 1462.271840] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13655)
> [ 1462.271852] cx18-0: api: incoming: req 0x00003557 ack 0x00003557
> cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1468.290206] cx18-0: warning: failed to be awakened upon RPU
> acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 20 msecs
> [ 1473.784866] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 14887) while
> processing
> [ 1482.287056] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 15789)
> [ 1482.287067] cx18-0: api: incoming: req 0x00003dad ack 0x00003dad
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1488.798573] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 16485)
> [ 1488.798585] cx18-0: api: incoming: req 0x00004065 ack 0x00004065
> cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1507.416354] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18463)
> [ 1507.416365] cx18-0: api: incoming: req 0x0000481f ack 0x0000481f
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1510.620047] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18802) while
> processing
> [ 1514.322277] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 19202) while
> processing
> [ 1535.844227] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 21490)
> [ 1535.844239] cx18-0: api: incoming: req 0x000053f2 ack 0x000053f2
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1542.453566] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 22194)
> [ 1542.453577] cx18-0: api: incoming: req 0x000056b2 ack 0x000056b2
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1558.067669] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 23843)
> [ 1558.067680] cx18-0: api: incoming: req 0x00005d23 ack 0x00005d23
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1565.474276] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 24628)
> [ 1565.474288] cx18-0: api: incoming: req 0x00006034 ack 0x00006034
> cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> 0x00000000 0x00000000 0x00000000
> [ 1573.382111] cx18-0: warning: Possibly falling behind: CPU
> self-ack'ed our incoming CPU to EPU mailbox (sequence no. 25465) while
> processing
>
> Let's change the channel again. Playback stops. log:
>
> [ 1696.430026] cx18-0: info: Input unchanged
> [ 1696.433796] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> args 0x00000001 0x00000001
> [ 1696.435486] cx18-0: info: Mute
> [ 1696.435491] cx18-0: info: v4l2 ioctl: set frequency 3092
> [ 1696.536031] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> 0x20020015 args 0x00000001 0x0000000c
> [ 1696.536109] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> args 0x00000001 0x00000000
> [ 1696.556037] cx18-0: warning: sending CX18_CPU_SET_AUDIO_MUTE timed
> out waiting 20 msecs for RPU acknowledgement
> [ 1696.556045] cx18-0: info: Unmute
> [ 1697.929472] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1697.940101] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
> [ 1697.952041] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1697.964776] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
> [ 1697.976055] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1697.988026] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
> [ 1698.000042] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1698.012028] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
> [ 1698.024027] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1698.036038] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
> [ 1698.048035] cx18-0: mbox was found stuck busy when setting up for
> CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> [ 1698.060025] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> waiting 12 msecs for RPU acknowledgement
>
> If I only enable the DVB tuner in MythTV and start up that way, I can
> have digital tv just fine. Sound works for the digital channels too.
> However, if I enable both analog and digital tuners and get into the
> above error situation by trying to change a station on the analog
> tuner, digital channels will not work after that anymore.
>
> Please advise. Any help will be appreciated.

The APU in your CX23418 chip is not behaving properly. Only having
problems with analog audio somewhat confirms that.

1. Check that your firmware images are correct - especially the APU
image.

2. Pull out all of your PCI cards; blow the dust out of the slots;
reinsert the cards; and try again.

3. Remove any non-critical PCI cards temporarily and test again.

4. To avoid a lot of disk activity while testing, don't test with
MythTV; test with mplayer:

$ ivtv-tune -d /dev/video0 -c 4 <---- Channel 4
$ mplayer /dev/video0 -cache 8192

5. Check with a Windows setup, ideally in the same machine, to determine
if the HVR-1600 could be defective.

Regards,
Andy

>
> Thank you,
>
> Michiel van Wessem
>



_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
windsunrain at gmail
Oct 25, 2009, 7:45 PM
Post #3 of 9 (5304 views)
Permalink
Thank you very much.

I'm trying your suggestions and will report back on the list when I've
been able to explore PCI options and a Windows install. I'm also trying
the firmware images that came with installation CDROM. dig and cpu
images are different from the ones found on linuxtv.org.

Thanks again.

Michiel van Wessem

On Sun, 2009-10-25 at 19:39 -0400, Andy Walls wrote:
> On Sun, 2009-10-25 at 10:38 -0400, Jacob Michael van Wessem wrote:
> > Hello,
> >
> > I'm having some problems with the Hauppage WinTV-HVR-1600 that I
> > recently bought. I'm running Jaunty on a system with an ASUS A7V333
> > motherboard with BIOS version 1017, AMD Athlon XP 1800+ and nVideo
> > GeForce 7600 GT video card with 256mb ram. The WinTV-HVR-1600 is the
> > kind with the MCE remote. Current kernel is labeled 2.6.28-16-generic
> > #55-Ubuntu SMP and I installed the
> > cx-18 module as per http://www.mythtv.org/wiki/Hauppauge_HVR-1600
> >
> > I'm having two problems:
> >
> > - Analog video has no sound.
> > - Changing the channel on the analog tuner stops playback and seems to
> > lock up all use of the WinTV-HVR-1600
> >
> > I hope you guys can help me resolve these problems.
> >
> > Here is a typical session:
> >
> > System startup:
> >
> > [ 14.927186] cx18: Start initialization, version 1.2.0
> > [ 14.927973] cx18-0: Initializing card 0
> > [ 14.927983] cx18-0: Autodetected Hauppauge card
> > [ 14.937864] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
> > IRQ 17
> > [ 14.937975] cx18-0: Unreasonably low latency timer, setting to 64
> > (was 32)
> > [ 14.943431] cx18-0: cx23418 revision 01010000 (B)
> > [ 15.234170] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> > serial# 6314962
> > [ 15.234179] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> > [ 15.234184] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> > 116, type 43)
> > [ 15.234190] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> > [ 15.234195] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> > [ 15.234199] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> > [ 15.234203] tveeprom 1-0050: has radio
> > [ 15.234207] cx18-0: Autodetected Hauppauge HVR-1600
> > [ 15.234213] cx18-0: Simultaneous Digital and Analog TV capture
> > supported
> > [ 15.421386] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> > [ 15.440345] tda9887 2-0043: creating new instance
> > [ 15.440354] tda9887 2-0043: tda988[5/6/7] found
> > [ 15.446498] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> > [ 15.467427] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> > [ 15.491851] tuner-simple 2-0061: creating new instance
> > [ 15.491862] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> > (FM1236MK3 or FM1236/F))
> > [ 15.494124] cx18-0: Registered device video0 for encoder MPEG (64 x
> > 32 kB)
> > [ 15.494132] DVB: registering new adapter (cx18)
> > [ 15.612500] MXL5005S: Attached at address 0x63
> > [ 15.612516] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> > QAM/8VSB Frontend)...
> > [ 15.612934] cx18-0: DVB Frontend registered
> > [ 15.612941] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> > [ 15.613067] cx18-0: Registered device video32 for encoder YUV (16 x
> > 128 kB)
> > [ 15.613238] cx18-0: Registered device vbi0 for encoder VBI (20 x
> > 51984 bytes)
> > [ 15.613341] cx18-0: Registered device video24 for encoder PCM audio
> > (256 x 4 kB)
> > [ 15.613438] cx18-0: Registered device radio0 for encoder radio
> > [ 15.613444] cx18-0: Initialized card: Hauppauge HVR-1600
> > [ 15.613539] cx18: End initialization
> > [ 15.678354] C-Media PCI 0000:00:05.0: PCI INT A -> GSI 17 (level,
> > low) -> IRQ 17
> > [ 22.928450] ivtv: Start initialization, version 1.4.1
> > [ 22.928559] ivtv: End initialization
> > [ 22.945289] lirc_pvr150: disagrees about version of symbol
> > ivtv_reset_ir_gpio
> > [ 22.945302] lirc_pvr150: Unknown symbol ivtv_reset_ir_gpio
> > [ 30.604990] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 30.771584] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> > bytes)
> > [ 30.795006] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 30.964545] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> > (141200 bytes)
> > [ 30.973159] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> > [ 31.300412] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 31.462333] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 31.801713] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-dig.fw
> > [ 31.991741] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> > bytes)
> > [ 32.009660] cx18-0 843: verified load of v4l-cx23418-dig.fw
> > firmware (16382 bytes)
> >
> > It's not clear to me why driver reports that firmware is requesting
> > apu and cpu again after reporting that they are loaded.
>
> That's normal. It's loaded twice to get around a firmware bug with
> digital TV.
>
>
> > I think the C-Media PCI line is for the onboard sound, not the
> > HVR-1600, but I've left it in here because it's sharing interrupt 17
> > with cx-18. cat /proc/interrupts:
> >
> > 17: 57174 IO-APIC-fasteoi ehci_hcd:usb1, cx18-0, CMI8738-MC6
> >
> > Is it possible that this interrupt sharing causes the lockups and lack
> > of sound?
>
> Your problem doewsn't look like it is related to the CX23418's interrupt
> being held off too long. So maybe, but not likely.
>
>
>
> > Alright. Start MythTV, go to watch TV. Analog playback starts, but
> > there is no audio. Nothing in kernel log.
> >
> > Now change the channel in MythTV. Playback stops indefinitely. Kernel
> > log shows this:
> > [ 1057.324029] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1057.348043] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1057.372025] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.332033] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_CAPTURE_STOP; clearing busy and trying to proceed
> > [ 1062.364024] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_RELEASE_MDL; clearing busy and trying to proceed
> > [ 1062.396025] cx18-0: mbox was found stuck busy when setting up for
> > CX18_DESTROY_TASK; clearing busy and trying to proceed
> > [ 1062.428038] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CREATE_TASK; clearing busy and trying to proceed
> > [ 1062.467782] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_CHANNEL_TYPE; clearing busy and trying to proceed
> > [ 1062.496033] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_VER_CROP_LINE; clearing busy and trying to proceed
> > [ 1062.528036] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.560034] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.592040] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.624030] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.656039] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_CAPTURE_LINE_NO; clearing busy and trying to proceed
> > [ 1062.688175] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_RAW_VBI_PARAM; clearing busy and trying to proceed
> > [ 1062.720046] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_INDEXTABLE; clearing busy and trying to proceed
> > [ 1062.752045] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_VIDEO_IN; clearing busy and trying to proceed
> > [ 1062.784029] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL_ACK; clearing busy and trying to proceed
> > [ 1062.816027] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.840041] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.864032] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.888051] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.912035] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.936031] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.960040] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
>
> This is a bad condition. I've never seen it happen before; I just put
> the log message in there in case it did one day. Repeated "stuck busy"
> messages indicate the CX23418 has gone "stupid" or is not responding
> properly.
>
>
> > OK. Let's rmmod cx18 and reload it with debug 15 (this will get more
> > verbose):
> >
> > [ 1193.934791] cx18: Start initialization, version 1.2.0
> > [ 1193.934907] cx18-0: Initializing card 0
> > [ 1193.934913] cx18-0: Autodetected Hauppauge card
> > [ 1193.943736] cx18-0: info: base addr: 0xc8000000
> > [ 1193.943742] cx18-0: info: Enabling pci device
> > [ 1193.943764] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
> > IRQ 17
> > [ 1193.943779] cx18-0: info: cx23418 (rev 0) at 00:0e.0, irq: 17,
> > latency: 64, memory: 0xc8000000
> > [ 1193.943783] cx18-0: info: attempting ioremap at 0xc8000000 len
> > 0x04000000
> > [ 1193.947747] cx18-0: cx23418 revision 01010000 (B)
> > [ 1194.038592] cx18-0: info: GPIO initial dir: 0000cffe/0000ffff out:
> > 00003001/00000000
> > [ 1194.038617] cx18-0: info: activating i2c...
> > [ 1194.212312] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> > serial# 6314962
> > [ 1194.212319] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> > [ 1194.212323] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> > 116, type 43)
> > [ 1194.212327] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> > [ 1194.212331] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> > [ 1194.212334] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> > [ 1194.212337] tveeprom 1-0050: has radio
> > [ 1194.212341] cx18-0: Autodetected Hauppauge HVR-1600
> > [ 1194.212344] cx18-0: info: NTSC tuner detected
> > [ 1194.212347] cx18-0: Simultaneous Digital and Analog TV capture
> > supported
> > [ 1194.351350] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> > [ 1194.351495] tda9887 2-0043: creating new instance
> > [ 1194.351498] tda9887 2-0043: tda988[5/6/7] found
> > [ 1194.357625] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> > [ 1194.362940] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> > [ 1194.365280] tuner-simple 2-0061: creating new instance
> > [ 1194.365288] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> > (FM1236MK3 or FM1236/F))
> > [ 1194.366682] cx18-0: info: Allocate encoder MPEG stream: 64 x 32768
> > buffers (2048kB total)
> > [ 1194.366767] cx18-0: info: Allocate TS stream: 32 x 32768 buffers
> > (1024kB total)
> > [ 1194.366804] cx18-0: info: Allocate encoder YUV stream: 16 x 131072
> > buffers (2048kB total)
> > [ 1194.366839] cx18-0: info: Allocate encoder VBI stream: 20 x 51984
> > buffers (1015kB total)
> > [ 1194.366870] cx18-0: info: Allocate encoder PCM audio stream: 256 x
> > 4096 buffers (1024kB total)
> > [ 1194.367043] cx18-0: info: Allocate encoder IDX stream: 32 x 32768
> > buffers (1024kB total)
> > [ 1194.367362] cx18-0: Registered device video0 for encoder MPEG (64 x
> > 32 kB)
> > [ 1194.367368] DVB: registering new adapter (cx18)
> > [ 1194.525014] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 1194.548213] MXL5005S: Attached at address 0x63
> > [ 1194.548227] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> > QAM/8VSB Frontend)...
> > [ 1194.567088] cx18-0: DVB Frontend registered
> > [ 1194.567095] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> > [ 1194.567139] cx18-0: Registered device video32 for encoder YUV (16 x
> > 128 kB)
> > [ 1194.567172] cx18-0: Registered device vbi0 for encoder VBI (20 x
> > 51984 bytes)
> > [ 1194.567203] cx18-0: Registered device video24 for encoder PCM audio
> > (256 x 4 kB)
> > [ 1194.567234] cx18-0: Registered device radio0 for encoder radio
> > [ 1194.567238] cx18-0: Initialized card: Hauppauge HVR-1600
> > [ 1194.567277] cx18: End initialization
> > [ 1194.665016] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> > bytes)
> > [ 1194.687326] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 1195.204144] cx18-0: info: load segment a00000-a07fff
> > [ 1195.223682] cx18-0: info: load segment ae0000-ae00ff
> > [ 1195.223839] cx18-0: info: load segment b00000-b1a65f
> > [ 1195.288238] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> > (141200 bytes)
> > [ 1195.294223] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> > (Release 2007/03/12)
> > [ 1195.294231] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> > [ 1195.684061] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> > args 0x00000000
> > [ 1195.684164] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> > 0x000000b9 0x00000000
> > [ 1195.685376] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> > [ 1195.704063] cx18-0: warning: sending CX18_APU_RESETAI timed out
> > waiting 20 msecs for RPU acknowledgement
> > [ 1195.704074] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> > 0x00000000
> > [ 1195.716054] cx18-0: mbox was found stuck busy when setting up for
> > CX18_APU_STOP; clearing busy and trying to proceed
> > [ 1195.736058] cx18-0: warning: sending CX18_APU_STOP timed out
> > waiting 20 msecs for RPU acknowledgement
>
> This shouldn't be happening. Something is wrong with your PCI bus, or
> your power, or your APU or CPU firmware image. Or you have a bad
> CX23418. The APU (audio processing unit) should respond and pick up its
> mail almost immediately, and not leave the APU's incoming mailbox busy
> (full).
>
>
>
> > [ 1195.740130] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 1195.906342] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 1196.034837] cx18-0: info: load segment a00000-a07fff
> > [ 1196.054586] cx18-0: info: load segment ae0000-ae00ff
> > [ 1196.054744] cx18-0: info: load segment b00000-b1a65f
> > [ 1196.125354] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> > (Release 2007/03/12)
> > [ 1196.416058] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> > args 0x00000000
> > [ 1196.416198] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> > 0x000000b9 0x00000000
> > [ 1196.417406] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> > [ 1196.417841] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> > 0x00000000
> > [ 1196.417925] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-dig.fw
> > [ 1196.629074] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> > bytes)
> > [ 1196.646410] cx18-0 843: verified load of v4l-cx23418-dig.fw
> > firmware (16382 bytes)
> > [ 1196.646511] cx18-0: info: Changing input from 1 to 0
> > [ 1196.646514] cx18-0: info: Mute
> > [ 1196.646518] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.874385] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.874466] cx18-0: info: Unmute
> > [ 1196.874471] cx18-0: info: Switching standard to 1000.
> > [ 1196.874475] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.874491] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.874495] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.874498] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.874501] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.874505] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.874510] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.876084] cx18-0: info: Mute
> > [ 1196.876088] cx18-0: info: v4l2 ioctl: set frequency 1076
> > [ 1196.880431] cx18-0: info: Unmute
> > [ 1196.883681] cx18-0: info: Mute
> > [ 1196.885911] cx18-0 843: info: decoder set video input 7, audio
> > input 0
> > [ 1196.885976] cx18-0: info: Unmute
> > [ 1196.907271] cx18-0: info: Mute
> > [ 1196.907281] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.907298] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.907301] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.907304] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.907307] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.907311] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.907316] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.910267] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.910337] cx18-0: info: Unmute
> > [ 1196.932515] cx18-0: info: Input unchanged
> > [ 1196.932528] cx18-0: info: Switching standard to b000.
> > [ 1196.932533] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.932550] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.932554] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.932557] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.932560] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.932563] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.932568] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.935640] cx18-0: info: Input unchanged
> > [ 1196.939236] cx18-0: info: Mute
> > [ 1196.939245] cx18-0: info: v4l2 ioctl: set frequency 2996
> > [ 1196.941995] cx18-0: info: Unmute
> >
> > Now try watching tv in MythTV again. Works (no sound)
> >
> > [ 1287.648309] cx18-0: info: Start feed: pid = 0x0 index = 0
> > [ 1287.648320] cx18-0: info: Starting Transport DMA
> > [ 1287.648324] cx18-0: info: Start encoder stream TS
> > [ 1287.648331] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1287.648568] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000000 0x00000007
> > [ 1287.648755] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000000 0x00dc0c50 0x00dc0c58
> > [ 1287.656157] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000000
> > [ 1287.956156] cx18-0: info: Stop feed: pid = 0x0 index = 0
> > [ 1287.956164] cx18-0: info: Stopping Transport DMA
> > [ 1287.956167] cx18-0: info: Stop Capture
> > [ 1287.956172] cx18-0: api: CX18_CPU_CAPTURE_STOP cmd 0x20020003
> > args 0x00000000
> > [ 1288.256042] cx18-0: api: CX18_CPU_DE_RELEASE_MDL cmd 0x20040006
> > args 0x00000000
> > [ 1288.556032] cx18-0: api: CX18_DESTROY_TASK cmd 0x40000002 args
> > 0x00000000
> > [ 1288.565268] cx18-0: info: Start feed: pid = 0x0 index = 0
> > [ 1288.565280] cx18-0: info: Starting Transport DMA
> > [ 1288.565284] cx18-0: info: Start encoder stream TS
> > [ 1288.565290] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1288.565359] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000000 0x00000007
> > [ 1288.565411] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000000 0x00dc0c50 0x00dc0c58
> > [ 1288.567396] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000000
> > [ 1288.864322] cx18-0: info: Start feed: pid = 0x1ffb index = 1
> > [ 1288.947032] cx18-0: info: Start feed: pid = 0x30 index = 2
> > [ 1288.986940] cx18-0: info: Start feed: pid = 0x31 index = 3
> > [ 1288.987026] cx18-0: info: Start feed: pid = 0x34 index = 4
> > [ 1289.027432] cx18-0: info: Start feed: pid = 0x1388 index = 5
> > [ 1289.027517] cx18-0: info: Start feed: pid = 0x1389 index = 6
> > [ 1289.027573] cx18-0: info: Start feed: pid = 0x138a index = 7
> > [ 1289.027627] cx18-0: info: Start feed: pid = 0x138b index = 8
> > [ 1289.027680] cx18-0: info: Start feed: pid = 0x1408 index = 9
> > [ 1289.027733] cx18-0: info: Start feed: pid = 0x1409 index = 10
> > [ 1289.027786] cx18-0: info: Start feed: pid = 0x140a index = 11
> > [ 1289.027840] cx18-0: info: Start feed: pid = 0x140b index = 12
> > [ 1343.893201] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> > [ 1393.845930] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> > [ 1437.591889] cx18-0: info: Input unchanged
> > [ 1437.595203] cx18-0: info: Mute
> > [ 1437.595211] cx18-0: info: v4l2 ioctl: set frequency 2996
> > [ 1437.597791] cx18-0: info: Unmute
> > [ 1438.785345] cx18-0 843: info: decoder set size 480x480 -> scale
> > 524288x0
> > [ 1438.785773] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0xffffffff 0x000000ba
> > [ 1438.785915] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.785974] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786028] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786178] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786231] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786284] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786379] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786433] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786486] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786574] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0xffffffff 0x000000ea
> > [ 1438.786632] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786686] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786738] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786827] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0xffffffff 0x00000000 0x005b8d80 0x00003a98 0x00000000
> > [ 1438.786892] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786954] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.787021] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.787507] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0xffffffff 0x00000000 0x0044aa20 0x00003a98 0x00000000
> > [ 1438.787714] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.787773] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.787829] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.787922] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.787978] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.793941] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.794952] cx18-0: info: Start encoder stream encoder MPEG
> > [ 1438.794959] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1438.795078] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000001 0x00000001
> > [ 1438.795206] cx18-0: api: CX18_CPU_SET_VER_CROP_LINE cmd 0x2002001b
> > args 0x00000001 0x00000000
> > [ 1438.795261] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000003 0x00000001
> > [ 1438.795317] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000008 0x00000000
> > [ 1438.795413] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000004 0x00000001
> > [ 1438.795544] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x0000000c
> > [ 1438.795596] cx18-0: api: CX18_CPU_SET_CAPTURE_LINE_NO cmd
> > 0x20020017 args 0x00000001 0x00000138 0x00000139
> > [ 1438.795680] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1438.795684] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1438.795688] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1438.795691] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1438.795694] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1438.795700] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1438.795747] cx18-0: info: Setup VBI h: 1 lines c000c bpl 1444 fr 1
> > 20602060 307090d0
> > [ 1438.795753] cx18-0: api: CX18_CPU_SET_RAW_VBI_PARAM cmd 0x20020016
> > args 0x00000001 0x000c000c 0x000005a4 0x00000001 0x20602060 0x307090d0
> > [ 1439.092027] cx18-0: api: CX18_CPU_SET_INDEXTABLE cmd 0x20020010
> > args 0x00000000
> > [ 1439.092089] cx18-0: api: CX18_CPU_SET_VIDEO_IN cmd 0x20020004
> > args 0x00000001 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000
> > [ 1439.092163] cx18-0: api: CX18_CPU_SET_VIDEO_RESOLUTION cmd
> > 0x20020006 args 0x00000001 0x000001e0 0x000001e0
> > [ 1439.092735] cx18-0: api: CX18_CPU_SET_STREAM_OUTPUT_TYPE cmd
> > 0x20020012 args 0x00000001 0x00000000
> > [ 1439.092796] cx18-0: api: CX18_CPU_SET_ASPECT_RATIO cmd 0x2002001e
> > args 0x00000001 0x00000002
> > [ 1439.092850] cx18-0: api: CX18_CPU_SET_GOP_STRUCTURE cmd 0x2002001c
> > args 0x00000001 0x0000000f 0x00000003
> > [ 1439.092901] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0x00000001 0x000000ea
> > [ 1439.092964] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000000
> > [ 1439.093028] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0x00000001 0x00000000 0x0044aa20 0x00003a98 0x00000000
> > [ 1439.093087] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000001 0x00000000 0x00000000
> > [ 1439.093142] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000000 0x00000000 0x00000000
> > [ 1439.093196] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000002 0x00000000 0x00000000
> > [ 1439.093251] cx18-0: api: CX18_CPU_SET_MEDIAN_CORING cmd 0x2002000e
> > args 0x00000001 0x00000000 0x000000ff 0x00000000 0x000000ff
> > [ 1439.093311] cx18-0: api: CX18_CPU_SET_SPATIAL_FILTER_TYPE cmd
> > 0x2002000c args 0x00000001 0x00000001 0x00000001
> > [ 1439.093368] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000001 0x00000000 0x00000000
> > [ 1439.093466] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000000 0x00000000 0x00000000
> > [ 1439.093530] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000002 0x00000000 0x00000000
> > [ 1439.093584] cx18-0: api: CX18_CPU_SET_SKIP_INPUT_FRAME cmd
> > 0x2002001f args 0x00000001 0x00000000
> > [ 1439.093633] cx18-0: api: CX18_CPU_SET_VIDEO_MUTE cmd 0x20020013
> > args 0x00000001 0x00808000
> > [ 1439.093684] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000007 0x00000000 0x00000000
> > [ 1439.093739] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000001 0x00dc0c40 0x00dc0c48
> > [ 1439.102576] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000001
> > [ 1446.654744] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 11990)
> > [ 1446.654757] cx18-0: api: incoming: req 0x00002ed6 ack 0x00002ed6
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1460.770887] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13494) while
> > processing
> > [ 1462.271840] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13655)
> > [ 1462.271852] cx18-0: api: incoming: req 0x00003557 ack 0x00003557
> > cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1468.290206] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 20 msecs
> > [ 1473.784866] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 14887) while
> > processing
> > [ 1482.287056] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 15789)
> > [ 1482.287067] cx18-0: api: incoming: req 0x00003dad ack 0x00003dad
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1488.798573] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 16485)
> > [ 1488.798585] cx18-0: api: incoming: req 0x00004065 ack 0x00004065
> > cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1507.416354] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18463)
> > [ 1507.416365] cx18-0: api: incoming: req 0x0000481f ack 0x0000481f
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1510.620047] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18802) while
> > processing
> > [ 1514.322277] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 19202) while
> > processing
> > [ 1535.844227] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 21490)
> > [ 1535.844239] cx18-0: api: incoming: req 0x000053f2 ack 0x000053f2
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1542.453566] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 22194)
> > [ 1542.453577] cx18-0: api: incoming: req 0x000056b2 ack 0x000056b2
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1558.067669] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 23843)
> > [ 1558.067680] cx18-0: api: incoming: req 0x00005d23 ack 0x00005d23
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1565.474276] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 24628)
> > [ 1565.474288] cx18-0: api: incoming: req 0x00006034 ack 0x00006034
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1573.382111] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 25465) while
> > processing
> >
> > Let's change the channel again. Playback stops. log:
> >
> > [ 1696.430026] cx18-0: info: Input unchanged
> > [ 1696.433796] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000001
> > [ 1696.435486] cx18-0: info: Mute
> > [ 1696.435491] cx18-0: info: v4l2 ioctl: set frequency 3092
> > [ 1696.536031] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x0000000c
> > [ 1696.536109] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000000
> > [ 1696.556037] cx18-0: warning: sending CX18_CPU_SET_AUDIO_MUTE timed
> > out waiting 20 msecs for RPU acknowledgement
> > [ 1696.556045] cx18-0: info: Unmute
> > [ 1697.929472] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.940101] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1697.952041] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.964776] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1697.976055] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.988026] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.000042] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.012028] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.024027] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.036038] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.048035] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.060025] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> >
> > If I only enable the DVB tuner in MythTV and start up that way, I can
> > have digital tv just fine. Sound works for the digital channels too.
> > However, if I enable both analog and digital tuners and get into the
> > above error situation by trying to change a station on the analog
> > tuner, digital channels will not work after that anymore.
> >
> > Please advise. Any help will be appreciated.
>
> The APU in your CX23418 chip is not behaving properly. Only having
> problems with analog audio somewhat confirms that.
>
> 1. Check that your firmware images are correct - especially the APU
> image.
>
> 2. Pull out all of your PCI cards; blow the dust out of the slots;
> reinsert the cards; and try again.
>
> 3. Remove any non-critical PCI cards temporarily and test again.
>
> 4. To avoid a lot of disk activity while testing, don't test with
> MythTV; test with mplayer:
>
> $ ivtv-tune -d /dev/video0 -c 4 <---- Channel 4
> $ mplayer /dev/video0 -cache 8192
>
> 5. Check with a Windows setup, ideally in the same machine, to determine
> if the HVR-1600 could be defective.
>
> Regards,
> Andy
>
> >
> > Thank you,
> >
> > Michiel van Wessem
> >
>
>




_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
windsunrain at gmail
Oct 28, 2009, 4:37 PM
Post #4 of 9 (5311 views)
Permalink
On Sun, 2009-10-25 at 19:39 -0400, Andy Walls wrote:
> On Sun, 2009-10-25 at 10:38 -0400, Jacob Michael van Wessem wrote:
> > Hello,
> >
> > I'm having some problems with the Hauppage WinTV-HVR-1600 that I
> > recently bought. I'm running Jaunty on a system with an ASUS A7V333
> > motherboard with BIOS version 1017, AMD Athlon XP 1800+ and nVideo
> > GeForce 7600 GT video card with 256mb ram. The WinTV-HVR-1600 is the
> > kind with the MCE remote. Current kernel is labeled 2.6.28-16-generic
> > #55-Ubuntu SMP and I installed the
> > cx-18 module as per http://www.mythtv.org/wiki/Hauppauge_HVR-1600
> >
> > I'm having two problems:
> >
> > - Analog video has no sound.
> > - Changing the channel on the analog tuner stops playback and seems to
> > lock up all use of the WinTV-HVR-1600
> >
> > I hope you guys can help me resolve these problems.
> >
> > Here is a typical session:
> >
> > System startup:
> >
> > [ 14.927186] cx18: Start initialization, version 1.2.0
> > [ 14.927973] cx18-0: Initializing card 0
> > [ 14.927983] cx18-0: Autodetected Hauppauge card
> > [ 14.937864] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->http://linuxtv.org/
> > IRQ 17
> > [ 14.937975] cx18-0: Unreasonably low latency timer, setting to 64
> > (was 32)
> > [ 14.943431] cx18-0: cx23418 revision 01010000 (B)
> > [ 15.234170] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> > serial# 6314962
> > [ 15.234179] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> > [ 15.234184] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> > 116, type 43)
> > [ 15.234190] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> > [ 15.234195] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> > [ 15.234199] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> > [ 15.234203] tveeprom 1-0050: has radio
> > [ 15.234207] cx18-0: Autodetected Hauppauge HVR-1600
> > [ 15.234213] cx18-0: Simultaneous Digital and Analog TV capture
> > supported
> > [ 15.421386] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> > [ 15.440345] tda9887 2-0043: creating new instance
> > [ 15.440354] tda9887 2-0043: tda988[5/6/7] found
> > [ 15.446498] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> > [ 15.467427] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> > [ 15.491851] tuner-simple 2-0061: creating new instance
> > [ 15.491862] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> > (FM1236MK3 or FM1236/F))
> > [ 15.494124] cx18-0: Registered device video0 for encoder MPEG (64 x
> > 32 kB)
> > [ 15.494132] DVB: registering new adapter (cx18)
> > [ 15.612500] MXL5005S: Attached at address 0x63
> > [ 15.612516] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> > QAM/8VSB Frontend)...
> > [ 15.612934] cx18-0: DVB Frontend registered
> > [ 15.612941] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> > [ 15.613067] cx18-0: Registered device video32 for encoder YUV (16 x
> > 128 kB)
> > [ 15.613238] cx18-0: Registered device vbi0 for encoder VBI (20 x
> > 51984 bytes)
> > [ 15.613341] cx18-0: Registered device video24 for encoder PCM audio
> > (256 x 4 kB)
> > [ 15.613438] cx18-0: Registered device radio0 for encoder radio
> > [ 15.613444] cx18-0: Initialized card: Hauppauge HVR-1600
> > [ 15.613539] cx18: End initialization
> > [ 15.678354] C-Media PCI 0000:00:05.0: PCI INT A -> GSI 17 (level,
> > low) -> IRQ 17
> > [ 22.928450] ivtv: Start initialization, version 1.4.1
> > [ 22.928559] ivtv: End initialization
> > [ 22.945289] lirc_pvr150: disagrees about version of symbol
> > ivtv_reset_ir_gpio
> > [ 22.945302] lirc_pvr150: Unknown symbol ivtv_reset_ir_gpio
> > [ 30.604990] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 30.771584] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> > bytes)
> > [ 30.795006] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 30.964545] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> > (141200 bytes)
> > [ 30.973159] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> > [ 31.300412] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 31.462333] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 31.801713] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-dig.fw
> > [ 31.991741] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> > bytes)
> > [ 32.009660] cx18-0 843: verified load of v4l-cx23418-dig.fw
> > firmware (16382 bytes)
> >
> > It's not clear to me why driver reports that firmware is requesting
> > apu and cpu again after reporting that they are loaded.
>
> That's normal. It's loaded twice to get around a firmware bug with
> digital TV.
>
>
> > I think the C-Media PCI line is for the onboard sound, not the
> > HVR-1600, but I've left it in here because it's sharing interrupt 17
> > with cx-18. cat /proc/interrupts:
> >
> > 17: 57174 IO-APIC-fasteoi ehci_hcd:usb1, cx18-0, CMI8738-MC6
> >
> > Is it possible that this interrupt sharing causes the lockups and lack
> > of sound?
>
> Your problem doewsn't look like it is related to the CX23418's interrupt
> being held off too long. So maybe, but not likely.
>
>
>
> > Alright. Start MythTV, go to watch TV. Analog playback starts, but
> > there is no audio. Nothing in kernel log.
> >
> > Now change the channel in MythTV. Playback stops indefinitely. Kernel
> > log shows this:
> > [ 1057.324029] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1057.348043] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1057.372025] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.332033] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_CAPTURE_STOP; clearing busy and trying to proceed
> > [ 1062.364024] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_RELEASE_MDL; clearing busy and trying to proceed
> > [ 1062.396025] cx18-0: mbox was found stuck busy when setting up for
> > CX18_DESTROY_TASK; clearing busy and trying to proceed
> > [ 1062.428038] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CREATE_TASK; clearing busy and trying to proceed
> > [ 1062.467782] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_CHANNEL_TYPE; clearing busy and trying to proceed
> > [ 1062.496033] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_VER_CROP_LINE; clearing busy and trying to proceed
> > [ 1062.528036] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.560034] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.592040] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.624030] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_MISC_PARAMETERS; clearing busy and trying to proceed
> > [ 1062.656039] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_CAPTURE_LINE_NO; clearing busy and trying to proceed
> > [ 1062.688175] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_RAW_VBI_PARAM; clearing busy and trying to proceed
> > [ 1062.720046] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_INDEXTABLE; clearing busy and trying to proceed
> > [ 1062.752045] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_SET_VIDEO_IN; clearing busy and trying to proceed
> > [ 1062.784029] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL_ACK; clearing busy and trying to proceed
> > [ 1062.816027] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.840041] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.864032] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.888051] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.912035] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.936031] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1062.960040] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
>
> This is a bad condition. I've never seen it happen before; I just put
> the log message in there in case it did one day. Repeated "stuck busy"
> messages indicate the CX23418 has gone "stupid" or is not responding
> properly.
>
>
> > OK. Let's rmmod cx18 and reload it with debug 15 (this will get more
> > verbose):
> >
> > [ 1193.934791] cx18: Start initialization, version 1.2.0
> > [ 1193.934907] cx18-0: Initializing card 0
> > [ 1193.934913] cx18-0: Autodetected Hauppauge card
> > [ 1193.943736] cx18-0: info: base addr: 0xc8000000
> > [ 1193.943742] cx18-0: info: Enabling pci device
> > [ 1193.943764] cx18 0000:00:0e.0: PCI INT A -> GSI 17 (level, low) ->
> > IRQ 17
> > [ 1193.943779] cx18-0: info: cx23418 (rev 0) at 00:0e.0, irq: 17,
> > latency: 64, memory: 0xc8000000
> > [ 1193.943783] cx18-0: info: attempting ioremap at 0xc8000000 len
> > 0x04000000
> > [ 1193.947747] cx18-0: cx23418 revision 01010000 (B)
> > [ 1194.038592] cx18-0: info: GPIO initial dir: 0000cffe/0000ffff out:
> > 00003001/00000000
> > [ 1194.038617] cx18-0: info: activating i2c...
> > [ 1194.212312] tveeprom 1-0050: Hauppauge model 74541, rev C6B6,
> > serial# 6314962
> > [ 1194.212319] tveeprom 1-0050: MAC address is 00-0D-FE-60-5B-D2
> > [ 1194.212323] tveeprom 1-0050: tuner model is Philips FM1236 MK5 (idx
> > 116, type 43)
> > [ 1194.212327] tveeprom 1-0050: TV standards NTSC(M) (eeprom 0x08)
> > [ 1194.212331] tveeprom 1-0050: audio processor is CX23418 (idx 38)
> > [ 1194.212334] tveeprom 1-0050: decoder processor is CX23418 (idx 31)
> > [ 1194.212337] tveeprom 1-0050: has radio
> > [ 1194.212341] cx18-0: Autodetected Hauppauge HVR-1600
> > [ 1194.212344] cx18-0: info: NTSC tuner detected
> > [ 1194.212347] cx18-0: Simultaneous Digital and Analog TV capture
> > supported
> > [ 1194.351350] tuner 2-0043: chip found @ 0x86 (cx18 i2c driver #0-1)
> > [ 1194.351495] tda9887 2-0043: creating new instance
> > [ 1194.351498] tda9887 2-0043: tda988[5/6/7] found
> > [ 1194.357625] tuner 2-0061: chip found @ 0xc2 (cx18 i2c driver #0-1)
> > [ 1194.362940] cs5345 1-004c: chip found @ 0x98 (cx18 i2c driver #0-0)
> > [ 1194.365280] tuner-simple 2-0061: creating new instance
> > [ 1194.365288] tuner-simple 2-0061: type set to 43 (Philips NTSC MK3
> > (FM1236MK3 or FM1236/F))
> > [ 1194.366682] cx18-0: info: Allocate encoder MPEG stream: 64 x 32768
> > buffers (2048kB total)
> > [ 1194.366767] cx18-0: info: Allocate TS stream: 32 x 32768 buffers
> > (1024kB total)
> > [ 1194.366804] cx18-0: info: Allocate encoder YUV stream: 16 x 131072
> > buffers (2048kB total)
> > [ 1194.366839] cx18-0: info: Allocate encoder VBI stream: 20 x 51984
> > buffers (1015kB total)
> > [ 1194.366870] cx18-0: info: Allocate encoder PCM audio stream: 256 x
> > 4096 buffers (1024kB total)
> > [ 1194.367043] cx18-0: info: Allocate encoder IDX stream: 32 x 32768
> > buffers (1024kB total)
> > [ 1194.367362] cx18-0: Registered device video0 for encoder MPEG (64 x
> > 32 kB)
> > [ 1194.367368] DVB: registering new adapter (cx18)
> > [ 1194.525014] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 1194.548213] MXL5005S: Attached at address 0x63
> > [ 1194.548227] DVB: registering adapter 0 frontend 0 (Samsung S5H1409
> > QAM/8VSB Frontend)...
> > [ 1194.567088] cx18-0: DVB Frontend registered
> > [ 1194.567095] cx18-0: Registered DVB adapter0 for TS (32 x 32 kB)
> > [ 1194.567139] cx18-0: Registered device video32 for encoder YUV (16 x
> > 128 kB)
> > [ 1194.567172] cx18-0: Registered device vbi0 for encoder VBI (20 x
> > 51984 bytes)
> > [ 1194.567203] cx18-0: Registered device video24 for encoder PCM audio
> > (256 x 4 kB)
> > [ 1194.567234] cx18-0: Registered device radio0 for encoder radio
> > [ 1194.567238] cx18-0: Initialized card: Hauppauge HVR-1600
> > [ 1194.567277] cx18: End initialization
> > [ 1194.665016] cx18-0: loaded v4l-cx23418-cpu.fw firmware (158332
> > bytes)
> > [ 1194.687326] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 1195.204144] cx18-0: info: load segment a00000-a07fff
> > [ 1195.223682] cx18-0: info: load segment ae0000-ae00ff
> > [ 1195.223839] cx18-0: info: load segment b00000-b1a65f
> > [ 1195.288238] cx18-0: loaded v4l-cx23418-apu.fw firmware V00120000
> > (141200 bytes)
> > [ 1195.294223] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> > (Release 2007/03/12)
> > [ 1195.294231] cx18-0: FW version: 0.0.74.0 (Release 2007/03/12)
> > [ 1195.684061] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> > args 0x00000000
> > [ 1195.684164] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> > 0x000000b9 0x00000000
> > [ 1195.685376] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> > [ 1195.704063] cx18-0: warning: sending CX18_APU_RESETAI timed out
> > waiting 20 msecs for RPU acknowledgement
> > [ 1195.704074] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> > 0x00000000
> > [ 1195.716054] cx18-0: mbox was found stuck busy when setting up for
> > CX18_APU_STOP; clearing busy and trying to proceed
> > [ 1195.736058] cx18-0: warning: sending CX18_APU_STOP timed out
> > waiting 20 msecs for RPU acknowledgement
>
> This shouldn't be happening. Something is wrong with your PCI bus, or
> your power, or your APU or CPU firmware image. Or you have a bad
> CX23418. The APU (audio processing unit) should respond and pick up its
> mail almost immediately, and not leave the APU's incoming mailbox busy
> (full).
>
>
>
> > [ 1195.740130] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-cpu.fw
> > [ 1195.906342] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-apu.fw
> > [ 1196.034837] cx18-0: info: load segment a00000-a07fff
> > [ 1196.054586] cx18-0: info: load segment ae0000-ae00ff
> > [ 1196.054744] cx18-0: info: load segment b00000-b1a65f
> > [ 1196.125354] cx18-0: info: 1 MiniMe Encoder Firmware 0.0.74.0
> > (Release 2007/03/12)
> > [ 1196.416058] cx18-0: api: CX18_CPU_DEBUG_PEEK32 cmd 0x20000003
> > args 0x00000000
> > [ 1196.416198] cx18-0: api: CX18_APU_START cmd 0x10000001 args
> > 0x000000b9 0x00000000
> > [ 1196.417406] cx18-0: api: CX18_APU_RESETAI cmd 0x10000005 args
> > [ 1196.417841] cx18-0: api: CX18_APU_STOP cmd 0x10000002 args
> > 0x00000000
> > [ 1196.417925] cx18 0000:00:0e.0: firmware: requesting
> > v4l-cx23418-dig.fw
> > [ 1196.629074] cx18-0 843: loaded v4l-cx23418-dig.fw firmware (16382
> > bytes)
> > [ 1196.646410] cx18-0 843: verified load of v4l-cx23418-dig.fw
> > firmware (16382 bytes)
> > [ 1196.646511] cx18-0: info: Changing input from 1 to 0
> > [ 1196.646514] cx18-0: info: Mute
> > [ 1196.646518] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.874385] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.874466] cx18-0: info: Unmute
> > [ 1196.874471] cx18-0: info: Switching standard to 1000.
> > [ 1196.874475] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.874491] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.874495] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.874498] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.874501] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.874505] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.874510] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.876084] cx18-0: info: Mute
> > [ 1196.876088] cx18-0: info: v4l2 ioctl: set frequency 1076
> > [ 1196.880431] cx18-0: info: Unmute
> > [ 1196.883681] cx18-0: info: Mute
> > [ 1196.885911] cx18-0 843: info: decoder set video input 7, audio
> > input 0
> > [ 1196.885976] cx18-0: info: Unmute
> > [ 1196.907271] cx18-0: info: Mute
> > [ 1196.907281] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.907298] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.907301] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.907304] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.907307] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.907311] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.907316] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.910267] cx18-0 843: info: decoder set video input 7, audio
> > input 8
> > [ 1196.910337] cx18-0: info: Unmute
> > [ 1196.932515] cx18-0: info: Input unchanged
> > [ 1196.932528] cx18-0: info: Switching standard to b000.
> > [ 1196.932533] cx18-0 843: info: changing video std to fmt 1
> > [ 1196.932550] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1196.932554] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1196.932557] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1196.932560] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1196.932563] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1196.932568] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1196.935640] cx18-0: info: Input unchanged
> > [ 1196.939236] cx18-0: info: Mute
> > [ 1196.939245] cx18-0: info: v4l2 ioctl: set frequency 2996
> > [ 1196.941995] cx18-0: info: Unmute
> >
> > Now try watching tv in MythTV again. Works (no sound)
> >
> > [ 1287.648309] cx18-0: info: Start feed: pid = 0x0 index = 0
> > [ 1287.648320] cx18-0: info: Starting Transport DMA
> > [ 1287.648324] cx18-0: info: Start encoder stream TS
> > [ 1287.648331] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1287.648568] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000000 0x00000007
> > [ 1287.648755] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000000 0x00dc0c50 0x00dc0c58
> > [ 1287.656157] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000000
> > [ 1287.956156] cx18-0: info: Stop feed: pid = 0x0 index = 0
> > [ 1287.956164] cx18-0: info: Stopping Transport DMA
> > [ 1287.956167] cx18-0: info: Stop Capture
> > [ 1287.956172] cx18-0: api: CX18_CPU_CAPTURE_STOP cmd 0x20020003
> > args 0x00000000
> > [ 1288.256042] cx18-0: api: CX18_CPU_DE_RELEASE_MDL cmd 0x20040006
> > args 0x00000000
> > [ 1288.556032] cx18-0: api: CX18_DESTROY_TASK cmd 0x40000002 args
> > 0x00000000
> > [ 1288.565268] cx18-0: info: Start feed: pid = 0x0 index = 0
> > [ 1288.565280] cx18-0: info: Starting Transport DMA
> > [ 1288.565284] cx18-0: info: Start encoder stream TS
> > [ 1288.565290] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1288.565359] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000000 0x00000007
> > [ 1288.565411] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000000 0x00dc0c50 0x00dc0c58
> > [ 1288.567396] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000000
> > [ 1288.864322] cx18-0: info: Start feed: pid = 0x1ffb index = 1
> > [ 1288.947032] cx18-0: info: Start feed: pid = 0x30 index = 2
> > [ 1288.986940] cx18-0: info: Start feed: pid = 0x31 index = 3
> > [ 1288.987026] cx18-0: info: Start feed: pid = 0x34 index = 4
> > [ 1289.027432] cx18-0: info: Start feed: pid = 0x1388 index = 5
> > [ 1289.027517] cx18-0: info: Start feed: pid = 0x1389 index = 6
> > [ 1289.027573] cx18-0: info: Start feed: pid = 0x138a index = 7
> > [ 1289.027627] cx18-0: info: Start feed: pid = 0x138b index = 8
> > [ 1289.027680] cx18-0: info: Start feed: pid = 0x1408 index = 9
> > [ 1289.027733] cx18-0: info: Start feed: pid = 0x1409 index = 10
> > [ 1289.027786] cx18-0: info: Start feed: pid = 0x140a index = 11
> > [ 1289.027840] cx18-0: info: Start feed: pid = 0x140b index = 12
> > [ 1343.893201] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> > [ 1393.845930] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 28 msecs
> > [ 1437.591889] cx18-0: info: Input unchanged
> > [ 1437.595203] cx18-0: info: Mute
> > [ 1437.595211] cx18-0: info: v4l2 ioctl: set frequency 2996
> > [ 1437.597791] cx18-0: info: Unmute
> > [ 1438.785345] cx18-0 843: info: decoder set size 480x480 -> scale
> > 524288x0
> > [ 1438.785773] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0xffffffff 0x000000ba
> > [ 1438.785915] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.785974] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786028] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786178] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786231] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786284] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786379] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786433] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786486] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786574] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0xffffffff 0x000000ea
> > [ 1438.786632] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786686] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.786738] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.786827] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0xffffffff 0x00000000 0x005b8d80 0x00003a98 0x00000000
> > [ 1438.786892] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.786954] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.787021] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.787507] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0xffffffff 0x00000000 0x0044aa20 0x00003a98 0x00000000
> > [ 1438.787714] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.787773] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.787829] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.787922] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000001 0x00000000 0x00000000
> > [ 1438.787978] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000000 0x00000000 0x00000000
> > [ 1438.793941] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0xffffffff 0x00000002 0x00000000 0x00000000
> > [ 1438.794952] cx18-0: info: Start encoder stream encoder MPEG
> > [ 1438.794959] cx18-0: api: CX18_CREATE_TASK cmd 0x40000001 args
> > 0x20020000
> > [ 1438.795078] cx18-0: api: CX18_CPU_SET_CHANNEL_TYPE cmd 0x20020001
> > args 0x00000001 0x00000001
> > [ 1438.795206] cx18-0: api: CX18_CPU_SET_VER_CROP_LINE cmd 0x2002001b
> > args 0x00000001 0x00000000
> > [ 1438.795261] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000003 0x00000001
> > [ 1438.795317] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000008 0x00000000
> > [ 1438.795413] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000004 0x00000001
> > [ 1438.795544] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x0000000c
> > [ 1438.795596] cx18-0: api: CX18_CPU_SET_CAPTURE_LINE_NO cmd
> > 0x20020017 args 0x00000001 0x00000138 0x00000139
> > [ 1438.795680] cx18-0 843: info: PLL regs = int: 15, frac: 2876158,
> > post: 4
> > [ 1438.795684] cx18-0 843: info: Video PLL = 107.999999 MHz
> > [ 1438.795688] cx18-0 843: info: Pixel rate = 13.499999 Mpixel/sec
> > [ 1438.795691] cx18-0 843: info: ADC XTAL/pixel clock decimation
> > ratio = 2.121
> > [ 1438.795694] cx18-0 843: info: Chroma sub-carrier initial freq =
> > 3.579545 MHz
> > [ 1438.795700] cx18-0 843: info: hblank 122, hactive 720, vblank 26,
> > vactive 481, vblank656 38, src_dec 543, burst 0x5a, luma_lpf 1, uv_lpf
> > 1, comb 0x66, sc 0x087c00
> > [ 1438.795747] cx18-0: info: Setup VBI h: 1 lines c000c bpl 1444 fr 1
> > 20602060 307090d0
> > [ 1438.795753] cx18-0: api: CX18_CPU_SET_RAW_VBI_PARAM cmd 0x20020016
> > args 0x00000001 0x000c000c 0x000005a4 0x00000001 0x20602060 0x307090d0
> > [ 1439.092027] cx18-0: api: CX18_CPU_SET_INDEXTABLE cmd 0x20020010
> > args 0x00000000
> > [ 1439.092089] cx18-0: api: CX18_CPU_SET_VIDEO_IN cmd 0x20020004
> > args 0x00000001 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000
> > [ 1439.092163] cx18-0: api: CX18_CPU_SET_VIDEO_RESOLUTION cmd
> > 0x20020006 args 0x00000001 0x000001e0 0x000001e0
> > [ 1439.092735] cx18-0: api: CX18_CPU_SET_STREAM_OUTPUT_TYPE cmd
> > 0x20020012 args 0x00000001 0x00000000
> > [ 1439.092796] cx18-0: api: CX18_CPU_SET_ASPECT_RATIO cmd 0x2002001e
> > args 0x00000001 0x00000002
> > [ 1439.092850] cx18-0: api: CX18_CPU_SET_GOP_STRUCTURE cmd 0x2002001c
> > args 0x00000001 0x0000000f 0x00000003
> > [ 1439.092901] cx18-0: api: CX18_CPU_SET_AUDIO_PARAMETERS cmd
> > 0x20020011 args 0x00000001 0x000000ea
> > [ 1439.092964] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000000
> > [ 1439.093028] cx18-0: api: CX18_CPU_SET_VIDEO_RATE cmd 0x20020005
> > args 0x00000001 0x00000000 0x0044aa20 0x00003a98 0x00000000
> > [ 1439.093087] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000001 0x00000000 0x00000000
> > [ 1439.093142] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000000 0x00000000 0x00000000
> > [ 1439.093196] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000002 0x00000000 0x00000000
> > [ 1439.093251] cx18-0: api: CX18_CPU_SET_MEDIAN_CORING cmd 0x2002000e
> > args 0x00000001 0x00000000 0x000000ff 0x00000000 0x000000ff
> > [ 1439.093311] cx18-0: api: CX18_CPU_SET_SPATIAL_FILTER_TYPE cmd
> > 0x2002000c args 0x00000001 0x00000001 0x00000001
> > [ 1439.093368] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000001 0x00000000 0x00000000
> > [ 1439.093466] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000000 0x00000000 0x00000000
> > [ 1439.093530] cx18-0: api: CX18_CPU_SET_FILTER_PARAM cmd 0x20020009
> > args 0x00000001 0x00000002 0x00000000 0x00000000
> > [ 1439.093584] cx18-0: api: CX18_CPU_SET_SKIP_INPUT_FRAME cmd
> > 0x2002001f args 0x00000001 0x00000000
> > [ 1439.093633] cx18-0: api: CX18_CPU_SET_VIDEO_MUTE cmd 0x20020013
> > args 0x00000001 0x00808000
> > [ 1439.093684] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x00000007 0x00000000 0x00000000
> > [ 1439.093739] cx18-0: api: CX18_CPU_DE_SET_MDL_ACK cmd 0x20040002
> > args 0x00000001 0x00dc0c40 0x00dc0c48
> > [ 1439.102576] cx18-0: api: CX18_CPU_CAPTURE_START cmd 0x20020002
> > args 0x00000001
> > [ 1446.654744] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 11990)
> > [ 1446.654757] cx18-0: api: incoming: req 0x00002ed6 ack 0x00002ed6
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1460.770887] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13494) while
> > processing
> > [ 1462.271840] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 13655)
> > [ 1462.271852] cx18-0: api: incoming: req 0x00003557 ack 0x00003557
> > cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1468.290206] cx18-0: warning: failed to be awakened upon RPU
> > acknowledgment sending CX18_CPU_DE_SET_MDL; timed out waiting 20 msecs
> > [ 1473.784866] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 14887) while
> > processing
> > [ 1482.287056] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 15789)
> > [ 1482.287067] cx18-0: api: incoming: req 0x00003dad ack 0x00003dad
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1488.798573] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 16485)
> > [ 1488.798585] cx18-0: api: incoming: req 0x00004065 ack 0x00004065
> > cmd 0x02040001 err 0x00000000 args 0x00000001 0x00dc0c48 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1507.416354] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18463)
> > [ 1507.416365] cx18-0: api: incoming: req 0x0000481f ack 0x0000481f
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1510.620047] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 18802) while
> > processing
> > [ 1514.322277] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 19202) while
> > processing
> > [ 1535.844227] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 21490)
> > [ 1535.844239] cx18-0: api: incoming: req 0x000053f2 ack 0x000053f2
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1542.453566] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 22194)
> > [ 1542.453577] cx18-0: api: incoming: req 0x000056b2 ack 0x000056b2
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c58 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1558.067669] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 23843)
> > [ 1558.067680] cx18-0: api: incoming: req 0x00005d23 ack 0x00005d23
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1565.474276] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 24628)
> > [ 1565.474288] cx18-0: api: incoming: req 0x00006034 ack 0x00006034
> > cmd 0x02040001 err 0x00000000 args 0x00000000 0x00dc0c50 0x00000001
> > 0x00000000 0x00000000 0x00000000
> > [ 1573.382111] cx18-0: warning: Possibly falling behind: CPU
> > self-ack'ed our incoming CPU to EPU mailbox (sequence no. 25465) while
> > processing
> >
> > Let's change the channel again. Playback stops. log:
> >
> > [ 1696.430026] cx18-0: info: Input unchanged
> > [ 1696.433796] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000001
> > [ 1696.435486] cx18-0: info: Mute
> > [ 1696.435491] cx18-0: info: v4l2 ioctl: set frequency 3092
> > [ 1696.536031] cx18-0: api: CX18_CPU_SET_MISC_PARAMETERS cmd
> > 0x20020015 args 0x00000001 0x0000000c
> > [ 1696.536109] cx18-0: api: CX18_CPU_SET_AUDIO_MUTE cmd 0x20020014
> > args 0x00000001 0x00000000
> > [ 1696.556037] cx18-0: warning: sending CX18_CPU_SET_AUDIO_MUTE timed
> > out waiting 20 msecs for RPU acknowledgement
> > [ 1696.556045] cx18-0: info: Unmute
> > [ 1697.929472] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.940101] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1697.952041] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.964776] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1697.976055] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1697.988026] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.000042] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.012028] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.024027] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.036038] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> > [ 1698.048035] cx18-0: mbox was found stuck busy when setting up for
> > CX18_CPU_DE_SET_MDL; clearing busy and trying to proceed
> > [ 1698.060025] cx18-0: warning: sending CX18_CPU_DE_SET_MDL timed out
> > waiting 12 msecs for RPU acknowledgement
> >
> > If I only enable the DVB tuner in MythTV and start up that way, I can
> > have digital tv just fine. Sound works for the digital channels too.
> > However, if I enable both analog and digital tuners and get into the
> > above error situation by trying to change a station on the analog
> > tuner, digital channels will not work after that anymore.
> >
> > Please advise. Any help will be appreciated.
>
> The APU in your CX23418 chip is not behaving properly. Only having
> problems with analog audio somewhat confirms that.
>
> 1. Check that your firmware images are correct - especially the APU
> image.
>
> 2. Pull out all of your PCI cards; blow the dust out of the slots;
> reinsert the cards; and try again.
>
> 3. Remove any non-critical PCI cards temporarily and test again.
>
> 4. To avoid a lot of disk activity while testing, don't test with
> MythTV; test with mplayer:
>
> $ ivtv-tune -d /dev/video0 -c 4 <---- Channel 4
> $ mplayer /dev/video0 -cache 8192
>
> 5. Check with a Windows setup, ideally in the same machine, to determine
> if the HVR-1600 could be defective.
>
> Regards,
> Andy


Hello Andy,

Thank you for your help.

I tried removing some other PCI cards and reseating the WinTV card. This
did not have any effect.

I also tried replacing the firmware images from linuxtv.org with the
ones I found on the CD that came with the card. This did not help.

So I found an old harddrive and installed XP and the WinTV software from
the CDROM. The WinTV software has a clumsy UI so I tried out SageTV. It
works flawless. No issues switching channels and no problems with sound!

Michiel



_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
windsunrain at gmail
Oct 31, 2009, 3:14 PM
Post #5 of 9 (5254 views)
Permalink
(removing long previous text, let me know if you'd like me to keep
including this)

Is there anything else I can try to get the driver to work?

How do the firmware images work? Does the cx-18 driver upload these to
the WinTV card, then have it bootstrap from these, or is it something
that runs on the main cpu?

Again, the card works under Windows. I understand this does not mean
there are no hardware issues under Windows - could be that the Windows
driver is more capable to deal with faulty hardware, no?

Thank you,

Michiel van Wessem


_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
awalls at radix
Oct 31, 2009, 6:18 PM
Post #6 of 9 (5255 views)
Permalink
On Sat, 2009-10-31 at 18:14 -0400, Jacob Michael van Wessem wrote:
> (removing long previous text, let me know if you'd like me to keep
> including this)
>
> Is there anything else I can try to get the driver to work?

>From what I understood you took it to a different machine and tested it
under window there, correct?

So you have eliminated the possibility of a defective card.

What's left could be a PCI bus problem or a firmware image problem. (I
think - I'm a bit tired right now.)

I believe in the first mail I gave you a few other things to try related
to simple PCI bus troubleshooting. Please try those.


You should also verify your firmwre images - please use the ones from
ivtvdriver.org - those are what the driver is developed against:

http://dl.ivtvdriver.org/ivtv/firmware/cx18-firmware.tar.gz


> How do the firmware images work? Does the cx-18 driver upload these to
> the WinTV card, then have it bootstrap from these, or is it something
> that runs on the main cpu?

1. APU firmware is uploaded to the CX23418
2. CPU firmware is uploaded to the CX23418
3. CPU firmware is started which will also start the APU firmware
4. A PEEK command is issued to the CPU to see if it is alive and
the APU is issued a RESETAI command to avoid audio problems
(superstition)
5. Steps 1-4 are repeated to overcome a TS stream bug and analog audio
encoding bug.
6. Digitizer firmware is loaded later when the digitizer is first
configured.
7. The digitizer firmware load is read back and verified.
8. The digitizer firmware is started.


As I recall from your previous logs, it looked like the APU in your
CX23418 was not running/responding to the RESETAI command. That's bad.
Is there anything in your dmesg or /var/log/messages about interrupts
being ignored or disabled because "nobody cared"?

You should try loading the cx18 module with the debug=255 parameter to
see if anything interesting shows up in dmesg or /var/log/messages.


> Again, the card works under Windows. I understand this does not mean
> there are no hardware issues under Windows - could be that the Windows
> driver is more capable to deal with faulty hardware, no?

No, Windows doesn't hammer on the PCI bus like Linux does. In more
recent kernels, Linux has gotten more agressive on PCI accesses,
especially at boot. This causes flaky buses or buses with bad
connections or quirky bridge chips to error out on some PCI bus
communications.

It is very much a function of you motherboard chipset, all the cards
plugged into the PCI bus, all the linux driver modules for those devices
and whatever other parts of Linux starts hammering on devices early on.

Regards,
Andy

> Thank you,
>
> Michiel van Wessem



_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
awalls at radix
Nov 3, 2009, 3:25 AM
Post #7 of 9 (5230 views)
Permalink
On Sat, 2009-10-31 at 18:14 -0400, Jacob Michael van Wessem wrote:
> (removing long previous text, let me know if you'd like me to keep
> including this)
>
> Is there anything else I can try to get the driver to work?

Michael,

You can als0 try blacklisting the cx18 module
in /etc/modporbe.d/blacklist (or your distribution's equivalent) and
then try to load the cx18 driver sometime after the flurry of boot
activity is over.

This might get you past getting the CX23418 loaded properly, but PCI bus
problems, if they exist, will give you other subtle symptoms with buffer
transfers.

Regards,
Andy



_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
windsunrain at gmail
Dec 3, 2009, 3:26 PM
Post #8 of 9 (4726 views)
Permalink
On Tue, 2009-11-03 at 06:25 -0500, Andy Walls wrote:
> On Sat, 2009-10-31 at 18:14 -0400, Jacob Michael van Wessem wrote:
> > (removing long previous text, let me know if you'd like me to keep
> > including this)
> >
> > Is there anything else I can try to get the driver to work?
>
> Michael,
>
> You can als0 try blacklisting the cx18 module
> in /etc/modporbe.d/blacklist (or your distribution's equivalent) and
> then try to load the cx18 driver sometime after the flurry of boot
> activity is over.
>
> This might get you past getting the CX23418 loaded properly, but PCI bus
> problems, if they exist, will give you other subtle symptoms with buffer
> transfers.

Hello Andy,

I don't know if you remember the problems I was having where the audio
wouldn't work on analog channels and everything stopped working as soon
as I tried changing the channel on the analog tuner. You suspected PCI
issues.

I returned the card and just received a replacement. This one worked out
of the box with the driver included with Karmic Ubuntu, so I'll conclude
the WinTV card was bad. This may or may not be related to a grounding
issue with a power outlet.

Thank you for supporting the driver.

Michiel




_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users
Re: Problems with cx-18 and Hauppage WinTV-HVR-1600 [ In reply to ]
awalls at radix
Dec 3, 2009, 3:53 PM
Post #9 of 9 (4736 views)
Permalink
On Thu, 2009-12-03 at 18:26 -0500, Jacob Michael van Wessem wrote:
> On Tue, 2009-11-03 at 06:25 -0500, Andy Walls wrote:
> > On Sat, 2009-10-31 at 18:14 -0400, Jacob Michael van Wessem wrote:
> > > (removing long previous text, let me know if you'd like me to keep
> > > including this)
> > >
> > > Is there anything else I can try to get the driver to work?
> >
> > Michael,
> >
> > You can als0 try blacklisting the cx18 module
> > in /etc/modporbe.d/blacklist (or your distribution's equivalent) and
> > then try to load the cx18 driver sometime after the flurry of boot
> > activity is over.
> >
> > This might get you past getting the CX23418 loaded properly, but PCI bus
> > problems, if they exist, will give you other subtle symptoms with buffer
> > transfers.
>
> Hello Andy,
>
> I don't know if you remember the problems I was having where the audio
> wouldn't work on analog channels and everything stopped working as soon
> as I tried changing the channel on the analog tuner. You suspected PCI
> issues.
>
> I returned the card and just received a replacement. This one worked out
> of the box with the driver included with Karmic Ubuntu, so I'll conclude
> the WinTV card was bad. This may or may not be related to a grounding
> issue with a power outlet.

Great, I'm glad it works for you. Feedback reports are always nice to
get.


> Thank you for supporting the driver.

You're welcome.

Regards,
Andy



_______________________________________________
ivtv-users mailing list
ivtv-users@ivtvdriver.org
http://ivtvdriver.org/mailman/listinfo/ivtv-users

©2024 GT.net. A Gossamer Threads company.
5th Floor, 455 Granville St., Vancouver, BC V6C 1T1, Canada | Legal