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 [email protected] http://ivtvdriver.org/mailman/listinfo/ivtv-users
