[mythtv-users] No audio during playback on one ATSC channel, streams miscrecognized in frontend? (KQED 9.1)

glen martin lists at locutory.org
Sat Jul 8 16:43:29 UTC 2006


So this used to work. :) I have since provisioned a new backend,
switched to later version of myth (ver 19 10258, if I read it
correctly), and I don't know if the station may have changed their
broadcast somehow (they have merged with another station). Too many
variables.

Anyway, recording most channels works well. Recordings on this channel
used to work.

On this one ATSC subchannel (SF Bay area KQED 9.1 in San Francisco, for
those as may care), no audio during playback. The backend seems to find
3 audio tracks during record, neither of two frontends seem to recognize
them and disables audio.

Below are a bit of analysis with a few log snippets, then 3 complete-ish
logs, trimmed to the starts and ends of the programs in question:

1) Backend during record for this recording
2) Frontend for this recording
3) Frontend for another high-bitrate ATSC program on a different
   channel for which sound works.

I can supply a backend log for the show that works if anyone wants. It
was in the first try of this post, but I ran up against a size limit
imposed by the mailing list. :)


I note a significant early difference between the frontend logs of
working and non-working programs. The one that works has some extra
startup that the no-audio program doesn't have:

<snip>
mpegts_add_stream: at pid 0x31 with type 2
mpegts_add_stream: stream #0, has id 0x31 and codec MPEG2VIDEO, type
Video at 0x82c3cb0
mpegts_add_stream: at pid 0x34 with type 129
mpegts_add_stream: stream #1, has id 0x34 and codec AC3, type Audio at
0x8eaff10
</snip>


The one that doesn't work goes on to notice the various streams, finding
perhaps a couple too many streams actually, but thinks they're all video


<snip>
2006-07-07 05:41:35.049 AFD: Stream #1, has id 0x5888 codec id
MPEG1VIDEO, type Video at 0x0x8d90060
2006-07-07 05:41:35.049 detectInterlace(Detect Scan, Detect Scan, 29.97,
480) ->Interlaced Scan
2006-07-07 05:41:35.049 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d967b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #2, has id 0x49 codec id MPEG2VIDEO,
type Video at 0x0x82c3cb0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 1088) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 1088
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG2VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82efa00, id(MPEG2VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #3, has id 0x52 codec id MPEG1VIDEO,
type Video at 0x0x8d828e0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 480) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d810b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #4, has id 0x53 codec id MPEG1VIDEO,
type Video at 0x0x82c7d10
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d990e0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #5, has id 0x51 codec id MPEG1VIDEO,
type Video at 0x0x828e910
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82c5f10, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.049 AFD: Stream #1, has id 0x5888 codec id
MPEG1VIDEO, type Video at 0x0x8d90060
2006-07-07 05:41:35.049 detectInterlace(Detect Scan, Detect Scan, 29.97,
480) ->Interlaced Scan
2006-07-07 05:41:35.049 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d967b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #2, has id 0x49 codec id MPEG2VIDEO,
type Video at 0x0x82c3cb0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 1088) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 1088
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG2VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82efa00, id(MPEG2VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #3, has id 0x52 codec id MPEG1VIDEO,
type Video at 0x0x8d828e0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 480) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d810b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #4, has id 0x53 codec id MPEG1VIDEO,
type Video at 0x0x82c7d10
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d990e0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #5, has id 0x51 codec id MPEG1VIDEO,
type Video at 0x0x828e910
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82c5f10, id(MPEG1VIDEO)
type(Video)
</snip>

where the backend recognized them as audio

<snip>
 Stream #1 pid(0x33) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Primary Audio
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(<=384kbps, 46)
      bsid(8) bs_mode(0) channels(<= 6) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
 Stream #2 pid(0x34) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Secondary Audio
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(=128kbps, 8)
      bsid(8) bs_mode(0) channels(1/0) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(fre) canonical(fre) eng(French)
 Stream #3 pid(0x35) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Secondary Audio 2
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(=128kbps, 8)
      bsid(8) bs_mode(0) channels(1/0) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(spa) canonical(spa) eng(Spanish; Castilian)
</snip>



Any clues as to what is going on here??


Thanks in advance,

glen



Here are the more complete logs promised.


Log 1: backend during record for show that doesn't work
===========================
2006-07-03 23:59:30.512 TVRec(1): SetFlags(AskAllowRecording,) ->
RunMainLoop,AskAllowRecording,RingBufferReset,
2006-07-03 23:59:30.513 TVRec(1): ClearFlags(AskAllowRecording,) ->
RunMainLoop,RingBufferReset,
2006-07-04 00:00:02.567 TVRec(1): StartRecording(Legends of Jazz With
Ramsey Lewis)
2006-07-04 00:00:02.570 TVRec(1): ClearFlags(AskAllowRecording,) ->
RunMainLoop,RingBufferReset,
2006-07-04 00:00:02.655 TVRec(1): StartedRecording(0x81bf180)
fn(/mnt/tv/1091_20060704000000.mpg)
2006-07-04 00:00:02.661 TVRec(1): ClearFlags(CancelNextRecording,) ->
RunMainLoop,RingBufferReset,
2006-07-04 00:00:02.662 TVRec(1): Changing from None to RecordingOnly
2006-07-04 00:00:02.663 TVRec(1):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,RingBufferReset,
2006-07-04 00:00:02.664 TVRec(1): SetFlags(AskAllowRecording,) ->
RunMainLoop,AskAllowRecording,RingBufferReset,
2006-07-04 00:00:02.665 TVRec(1): Request: Program(yes) channel()
input() flags(Recording,)
2006-07-04 00:00:02.666 TVRec(1): ClearFlags(PENDINGACTIONS,) ->
RunMainLoop,AskAllowRecording,RingBufferReset,
2006-07-04 00:00:02.672 DVB#1 Opening DVB channel
2006-07-04 00:00:02.681 DVB#1 SetChannelByString(9_1)
2006-07-04 00:00:02.686 DVB#1 Frequency: 569000000 Modulation: QPSK
2006-07-04 00:00:02.689 DVB#1 Old Params: freq(207000000) type(ATSC)
2006-07-04 00:00:02.690 DVB#1 New Params: freq(569000000) type(ATSC)
2006-07-04 00:00:02.784 dvbchannel.cpp:wait_for_backend: Status:
2006-07-04 00:00:02.785 DVB#1 DVBChannel::Tune: Frequency tuning successful.
2006-07-04 00:00:02.786 DVB#1 Tuned to frequency for channel 9_1.
2006-07-04 00:00:02.787 TVRec(1): Starting Signal Monitor
2006-07-04 00:00:02.788 TVRec(1): SetupSignalMonitor(1, 0)
2006-07-04 00:00:02.788 DVB#1 Opening DVB channel
2006-07-04 00:00:03.046 SM(1)::AddFlags: Seen() Match()
Wait(Sig,SNR,BER,UB,)
2006-07-04 00:00:03.047 DVBSM(1)::constructor(): initial flags 0x7400000
2006-07-04 00:00:03.048 TVRec(1): Signal monitor successfully created
2006-07-04 00:00:03.049 TVRec(1): Setting up table monitoring.
2006-07-04 00:00:03.050 TVRec(1): ATSC channel: 9_1
2006-07-04 00:00:03.051 DTVSM(1)::SetChannel(9, 1):
2006-07-04 00:00:03.052 SM(1)::RemoveFlags: Seen(PAT,PMT,VCT,)
Match(PAT,PMT,VCT,) Wait()
2006-07-04 00:00:03.053 SM(1)::AddFlags: Seen() Match() Wait(PAT,VCT,)
2006-07-04 00:00:03.059 SM(1)::AddFlags: Seen() Match() Wait(MGT,)
2006-07-04 00:00:03.060 TVRec(1): Successfully set up ATSC table monitoring.
2006-07-04 00:00:03.061 SM(1)::Start: begin
2006-07-04 00:00:03.063 SM(1)::Start: end
2006-07-04 00:00:03.065 TVRec(1): SetFlags(SignalMonitorRunning,) ->
RunMainLoop,AskAllowRecording,SignalMonitorRunning,RingBufferReset,
2006-07-04 00:00:03.066 TVRec(1): ClearFlags(WaitingForSignal,) ->
RunMainLoop,AskAllowRecording,SignalMonitorRunning,RingBufferReset,
2006-07-04 00:00:03.067 TVRec(1): SetFlags(WaitingForSignal,) ->
RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,RingBu
fferReset,
2006-07-04 00:00:03.068 TVRec(1): ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,R
ingBufferReset,
2006-07-04 00:00:03.069 TVRec(1): SetFlags(NeedToStartRecorder,) ->
RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,Sign
alMonitorRunning,RingBufferReset,
2006-07-04 00:00:03.127 DVB#1 Old Params: freq(569000000) type(ATSC)
2006-07-04 00:00:03.128 DVB#1 New Params: freq(569000000) type(ATSC)
2006-07-04 00:00:03.255 dvbchannel.cpp:wait_for_backend: Status:
2006-07-04 00:00:03.260 DVB#1 DVBChannel::Tune: Frequency tuning successful.
2006-07-04 00:00:03.264 Started recording: Legends of Jazz With Ramsey
Lewis "The Golden Horns": channel 1091 on cardid 1, sourceid 1
2006-07-04 00:00:03.436 DVBSM(1)::UpdateValues: Signal Locked
2006-07-04 00:00:03.442 DVBSM(1)::UpdateValues: Waiting for table
monitor to start
2006-07-04 00:00:03.443 DVBSM(1)::UpdateValues: Table monitor started
2006-07-04 00:00:03.454 DVBSM(1): RunTableMonitorTS(): begin (# of pids 2)
2006-07-04 00:00:03.455 DVBSM(1)::AddPIDFilter(0x0):
2006-07-04 00:00:03.458 DVBSM(1)::AddPIDFilter(0x1ffb):
2006-07-04 00:00:03.660 SM(1)::AddFlags: Seen(PAT,) Match() Wait()
2006-07-04 00:00:03.662 SM(1)::AddFlags: Seen(MGT,) Match() Wait()
2006-07-04 00:00:03.662 SM(1)::AddFlags: Seen() Match(MGT,) Wait()
2006-07-04 00:00:03.713 SM(1)::AddFlags: Seen(VCT,TVCT,) Match() Wait()
2006-07-04 00:00:03.714 DTVSM(1)::SetVCT(): tvct->ProgramNumber(idx 0):
prog num 1
2006-07-04 00:00:03.715 DTVSM(1)::SetProgramNumber(1):
2006-07-04 00:00:03.716 SM(1)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
2006-07-04 00:00:03.717 SM(1)::AddFlags: Seen() Match() Wait(PMT,)
2006-07-04 00:00:03.718 SM(1)::AddFlags: Seen() Match(VCT,TVCT,) Wait()
2006-07-04 00:00:03.719 SM(1)::AddFlags: Seen(PAT,) Match() Wait()
2006-07-04 00:00:03.720 SM(1)::AddFlags: Seen() Match(PAT,) Wait()
2006-07-04 00:00:03.721 CreatePATSingleProgram()
2006-07-04 00:00:03.722 PAT in input stream
2006-07-04 00:00:03.723 Program Association Table
 PSIP prefix(0x0) tableID(0x0) length(25) extension(0x17f)
      version(18) current(1) section(0) last_section(0)
         tsid: 383
 programCount: 4
  program number 1 has PID 0x  30   data  0x0 0x1 0x224 0x48
  program number 2 has PID 0x  40   data  0x0 0x2 0x224 0x64
  program number 3 has PID 0x  50   data  0x0 0x3 0x224 0x80
  program number 5 has PID 0x  70   data  0x0 0x5 0x224 0x112

2006-07-04 00:00:03.724 desired_program(1) pid(0x30)
2006-07-04 00:00:03.725 pmt_pid(0x30)
2006-07-04 00:00:03.726 PAT for output stream
2006-07-04 00:00:03.727 Program Association Table
 PSIP prefix(0x0) tableID(0x0) length(13) extension(0x17f)
      version(18) current(1) section(0) last_section(0)
         tsid: 383
 programCount: 1
  program number 1 has PID 0x  30   data  0x0 0x1 0x224 0x48

2006-07-04 00:00:03.728 DVBSM(1)::AddPIDFilter(0x30):
2006-07-04 00:00:04.181 SM(1)::AddFlags: Seen(PMT,) Match() Wait()
2006-07-04 00:00:04.182 SM(1)::AddFlags: Seen() Match(PMT,) Wait()
2006-07-04 00:00:04.183 CreatePMTSingleProgram()
2006-07-04 00:00:04.184 PMT in input stream
2006-07-04 00:00:04.185 Program Map Table ver(5) pid(0x30) pnum(1)
  Registration Descriptor: 'GA94' ATSC program ID A/53
  Smoothing Buffer Descriptor (0x10) length(6)
  Component Name Descriptor  lang(Unknown) KQED-HD
  Consumer Restrictions Control Descriptor (0xaa) length(1)

 Stream #0 pid(0x31) type(video-mpeg2  0x2)
  Unknown(6) Descriptor (0x6) length(1)
  Caption Service Descriptor  services(1)
     lang(eng) type(1) easy_reader(0) wide(1) service_num(1)
 Stream #1 pid(0x33) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Primary Audio
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(<=384kbps, 46)
      bsid(8) bs_mode(0) channels(<= 6) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
 Stream #2 pid(0x34) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Secondary Audio
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(=128kbps, 8)
      bsid(8) bs_mode(0) channels(1/0) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(fre) canonical(fre) eng(French)
 Stream #3 pid(0x35) type(audio-ac3  0x129)
  Registration Descriptor: 'AC-3' ATSC audio stream A/52
  Component Name Descriptor  lang(Unknown) Secondary Audio 2
  Audio Stream Descriptor  full_srv(1) sample_rate(48kbps)
bit_rate(=128kbps, 8)
      bsid(8) bs_mode(0) channels(1/0) Dolby(Not indicated)
      mainID(0)
  ISO-639 Language: code(spa) canonical(spa) eng(Spanish; Castilian)

2006-07-04 00:00:04.186 PMT for output stream
2006-07-04 00:00:04.187 Program Map Table ver(5) pid(0x30) pnum(1)

 Stream #0 pid(0x31) type(video-mpeg2  0x2)
 Stream #1 pid(0x33) type(audio-ac3  0x129)
 Stream #2 pid(0x34) type(audio-ac3  0x129)
 Stream #3 pid(0x35) type(audio-ac3  0x129)

2006-07-04 00:00:04.217 TVRec(1): Got good signal
2006-07-04 00:00:04.218 TVRec(1): MPEG program num(1)
2006-07-04 00:00:04.219 TVRec(1): TeardownSignalMonitor() -- begin
2006-07-04 00:00:04.228 DVBSM(1)::Stop: begin
2006-07-04 00:00:04.229 SM(1)::Stop: begin
2006-07-04 00:00:04.268 SM(1)::Stop: end
2006-07-04 00:00:04.288 DVBSM(1): RunTableMonitorTS(): shutdown
2006-07-04 00:00:04.289 DVBSM(1)::RemovePIDFilter(0x0):
2006-07-04 00:00:04.290 DVBSM(1)::RemovePIDFilter(0x30):
2006-07-04 00:00:04.291 DVBSM(1)::RemovePIDFilter(0x1ffb):
2006-07-04 00:00:04.610 DVBSM(1): RunTableMonitorTS(): end
2006-07-04 00:00:04.612 DVBSM(1)::Stop: end
2006-07-04 00:00:04.613 DVBSM(1)::Stop: begin
2006-07-04 00:00:04.614 SM(1)::Stop: begin
2006-07-04 00:00:04.615 SM(1)::Stop: end
2006-07-04 00:00:04.616 DVBSM(1)::Stop: end
2006-07-04 00:00:04.617 DVBSM(1)::Stop: begin
2006-07-04 00:00:04.617 SM(1)::Stop: begin
2006-07-04 00:00:04.618 SM(1)::Stop: end
2006-07-04 00:00:04.619 DVBSM(1)::Stop: end
2006-07-04 00:00:04.620 TVRec(1): TeardownSignalMonitor() -- end
2006-07-04 00:00:04.621 TVRec(1):
ClearFlags(WaitingForSignal,SignalMonitorRunning,) ->
RunMainLoop,AskAllowRecording,NeedToStartRecorder,R
ingBufferReset,
2006-07-04 00:00:04.622 TVRec(1): prog_num(1) vs. dvbc->srv_id(0)
2006-07-04 00:00:04.623 DVB#1 DVB SI Table Parser Started
2006-07-04 00:00:04.625 TVRec(1):
SetFlags(WaitingForSIParser,SIParserRunning,) ->
RunMainLoop,AskAllowRecording,WaitingForSIParser,NeedToS
tartRecorder,SIParserRunning,RingBufferReset,
2006-07-04 00:00:04.620 DVBSM(1)::Stop: begin
2006-07-04 00:00:04.629 SM(1)::Stop: begin
2006-07-04 00:00:04.630 SM(1)::Stop: end
2006-07-04 00:00:04.631 DVBSM(1)::Stop: end
2006-07-04 00:00:04.632 SM(1)::Stop: begin
2006-07-04 00:00:04.633 SM(1)::Stop: end
2006-07-04 00:00:04.925 DVB#1 SetPMT  ServiceID=1, PCRPID=49 (0x31)
2006-07-04 00:00:04.927 TVRec(1): Got SIParser PMT
2006-07-04 00:00:04.928 TVRec(1): ClearFlags(WaitingForSIParser,) ->
RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,Ring
BufferReset,
2006-07-04 00:00:04.929 TVRec(1): Starting Recorder
2006-07-04 00:00:04.934 TVRec(1): Using profile 'Default' to record
2006-07-04 00:00:04.975 RecBase(1): SetRingBuffer(0xaeb30720)
'/mnt/tv/1091_20060704000000.mpg'
2006-07-04 00:00:04.977 RecBase(1): SetRecording(0x81bf180)
title(Legends of Jazz With Ramsey Lewis)
2006-07-04 00:00:04.981 DVBRec(1): Card opened successfully fd(19)
(using TS mode).
2006-07-04 00:00:04.982 DVBRec(1): SetPMTObject()
2006-07-04 00:00:04.983 DVBRec(1): AutoPID for MPEG Program Number(1),
PCR PID(0x31)
2006-07-04 00:00:04.984 DVBRec(1): AutoPID recording PID 0x31, MPEG-2 Video
2006-07-04 00:00:04.985 DVBRec(1): AutoPID recording PID 0x33, AC3 Audio
(eng
2006-07-04 00:00:04.986 DVBRec(1): AutoPID recording PID 0x34, AC3 Audio
(fre
2006-07-04 00:00:04.987 DVBRec(1): AutoPID recording PID 0x35, AC3 Audio
(spa
2006-07-04 00:00:04.988 DVBRec(1): AutoPID Complete - PAT/PMT Loaded for
service
                        A/V Streams are unencrypted
2006-07-04 00:00:04.991 TVRec(1): SetFlags(RecorderRunning,) ->
RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderR
unning,RingBufferReset,
2006-07-04 00:00:04.993 TVRec(1): ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBuf
ferReset,
2006-07-04 00:00:05.025 DevRdB(1): buffer size 9400 KB
2006-07-04 00:00:05.027 DVBRec(1): Resetting Demux Filters
2006-07-04 00:00:05.029 DVBRec(1): Adding pid 0x31 size(3600384)
2006-07-04 00:00:05.031 DVBRec(1): Set demux buffer size for pid 0x31 to
3600384,
                        which gives us a 1500 msec buffer.
2006-07-04 00:00:05.032 DVBRec(1): Adding pid 0x33 size(94208)
2006-07-04 00:00:05.034 DVBRec(1): Set demux buffer size for pid 0x33 to
94208,
                        which gives us a 1500 msec buffer.
2006-07-04 00:00:05.035 DVBRec(1): Adding pid 0x34 size(94208)
2006-07-04 00:00:05.036 DVBRec(1): Set demux buffer size for pid 0x34 to
94208,
                        which gives us a 1500 msec buffer.
2006-07-04 00:00:05.037 DVBRec(1): Adding pid 0x35 size(94208)
2006-07-04 00:00:05.038 DVBRec(1): Set demux buffer size for pid 0x35 to
94208,
                        which gives us a 1500 msec buffer.
2006-07-04 00:00:05.453 PID 0x31 Found Payload Start
2006-07-04 00:00:05.473 PID 0x34 Found Payload Start
2006-07-04 00:00:05.511 PID 0x35 Found Payload Start
2006-07-04 00:00:05.632 PID 0x33 Found Payload Start
[mpeg2video @ 0xb7466bc4]ac-tex damaged at 21 23
[mpeg2video @ 0xb7466bc4]Warning MVs not available
.. removed stuff about a commercial flagging job at 00:20: ..
2006-07-04 00:30:00.811 TVRec(1): ClearFlags(FinishRecording,) ->
RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferR
eset,
2006-07-04 00:30:00.828 TVRec(1): Changing from RecordingOnly to None
2006-07-04 00:30:00.829 TVRec(1):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,AskAllowRecording,SIParserRunning,RecorderR
unning,RingBufferReset,
2006-07-04 00:30:00.830 TVRec(1): SetFlags(AskAllowRecording,) ->
RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferR
eset,
2006-07-04 00:30:00.831 TVRec(1): Request: Program(no) channel() input()
flags(CloseRec,KillRingBuffer,)
2006-07-04 00:30:00.847 TVRec(1): ClearFlags(SIParserRunning,) ->
RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReset,
2006-07-04 00:30:00.873 TVRec(1): FinishedRecording(Legends of Jazz With
Ramsey Lewis) in recgroup: Default
2006-07-04 00:30:00.877 Finished recording Legends of Jazz With Ramsey
Lewis "The Golden Horns": channel 1091
===========================




Log 2: frontend for show that doesn't work
===========================
2006-07-07 05:41:32.983 TV: Attempting to change from None to
WatchingPreRecorded
2006-07-07 05:41:32.986
RingBuf(myth://192.168.0.115:6543/1091_20060704000000.mpg):
OpenFile(myth://19
2.168.0.115:6543/1091_20060704000000.mpg, 12)
2006-07-07 05:41:33.073 reads allowed (128001 -1)
2006-07-07 05:41:33.097 reads allowed (128001 -1)
2006-07-07 05:41:33.983 reads allowed (128001 -1)
2006-07-07 05:41:34.479 reads allowed (128001 -1)
2006-07-07 05:41:34.566 reads allowed (128001 -1)
0: start_time: 2011768.432 duration: -9223372036854.775
1: start_time: 6705.482 duration: 161.654
2: start_time: 6705.536 duration: 161.600
3: start_time: 6705.482 duration: 161.582
4: start_time: 6705.484 duration: 161.582
5: start_time: 6705.495 duration: 161.556
stream: start_time: 74505.352 duration: 1796.159 bitrate=9969 kb/s
2006-07-07 05:41:35.049 AFD: Stream #0, has id 0x0 codec id MPEG2TS,
type Data at 0x0x82c02f0
2006-07-07 05:41:35.049 AFD: data codec (Data)
2006-07-07 05:41:35.049 AFD: Stream #1, has id 0x5888 codec id
MPEG1VIDEO, type Video at 0x0x8d90060
2006-07-07 05:41:35.049 detectInterlace(Detect Scan, Detect Scan, 29.97,
480) ->Interlaced Scan
2006-07-07 05:41:35.049 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d967b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #2, has id 0x49 codec id MPEG2VIDEO,
type Video at 0x0x82c3cb0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 1088) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 1088
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG2VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82efa00, id(MPEG2VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #3, has id 0x52 codec id MPEG1VIDEO,
type Video at 0x0x8d828e0
2006-07-07 05:41:35.050 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 480) ->Interlaced Scan
2006-07-07 05:41:35.050 Interlaced: Interlaced Scan  video_height: 480
fps: 29.97
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d810b0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #4, has id 0x53 codec id MPEG1VIDEO,
type Video at 0x0x82c7d10
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x8d990e0, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050 AFD: Stream #5, has id 0x51 codec id MPEG1VIDEO,
type Video at 0x0x828e910
2006-07-07 05:41:35.050 AFD: Looking for decoder for MPEG1VIDEO
2006-07-07 05:41:35.050 AFD: Opened codec 0x82c5f10, id(MPEG1VIDEO)
type(Video)
2006-07-07 05:41:35.050
RingBuf(myth://192.168.0.115:6543/1091_20060704000000.mpg):
CalcReadAheadThres
h(25061 KB)
                         -> threshhold(1173 KB) min read(32 KB) blk
size(512 KB)
2006-07-07 05:41:35.050 NVP: Disabling Audio, params(-1,-1,-1)
2006-07-07 05:41:35.050 AFD: Initializing audio parms from audio track #0
2006-07-07 05:41:35.051 AFD: Audio format changed
                        from id(NONE)    -1Hz -1ch   0bps    ;
id(NONE)    -1Hz -1ch   0bps
                        to   id(NONE)    -1Hz -1ch   0bps    ;
id(NONE)    -1Hz -1ch   0bps
2006-07-07 05:41:35.051 NVP: Disabling Audio, params(0,-1,-1)
2006-07-07 05:41:35.051 Resyncing position map. posmapStarted = 0
livetv(0) watchingRec(0)
2006-07-07 05:41:35.159 reads allowed (524289 32768)
2006-07-07 05:41:35.171 Position map filled from DB to: 53775
2006-07-07 05:41:35.171 SyncPositionMap prerecorded, from DB: 3586 entries
2006-07-07 05:41:35.171 SyncPositionMap, new totframes: 53775, new
length: 1794, posMap size: 3586
Input #0, mpegts, from 'myth://192.168.0.115:6543/1091_20060704000000.mpg':
  Duration: 00:29:56.1, start: 74505.351889, bitrate: 9969 kb/s
  Stream #0.0[0x0], 1/27000000: Data: mpeg2ts, 13048 kb/s
  Stream #0.1[0x1700], 1/90000,   inf fps(c): Video: mpeg1video
  Stream #0.2[0x31], 1/90000, 29.97 fps(r): Video: mpeg2video, yuv420p,
1920x1080, 1001/30000, 12011 k
b/s
  Stream #0.3[0x34], 1/90000,   inf fps(c): Video: mpeg1video
  Stream #0.4[0x35], 1/90000,   inf fps(c): Video: mpeg1video
  Stream #0.5[0x33], 1/90000,   inf fps(c): Video: mpeg1video
2006-07-07 05:41:35.172 AFD: Position map found
2006-07-07 05:41:35.172 AFD: Successfully opened decoder for file:
"myth://192.168.0.115:6543/1091_200
60704000000.mpg". novideo(0)
2006-07-07 05:41:35.184 VideoOutputXv: ctor
2006-07-07 05:41:35.185 Over/underscan. V: 0.01, H: 0, XOff: 0, YOff: 0
2006-07-07 05:41:35.210 Image size. dispxoff 0, dispyoff: 0, dispwoff:
1024, disphoff: 768
2006-07-07 05:41:35.210 Image size. imgx 0, imgy: 5, imgw: 640, imgh: 470
2006-07-07 05:41:35.210 VideoOutputXv: Pixel dimensions: Screen
1024x768, window 1024x768
2006-07-07 05:41:35.210 VideoOutputXv: Estimated display dimensions:
347x260 mm Aspect: 1.33462
2006-07-07 05:41:35.211 VideoOutputXv: Estimated window dimensions:
347x260 mm Aspect: 1.33462
2006-07-07 05:41:35.212 VideoOutputXv: @ j=3 Looking for flag[s]:
XvInputMask XvImageMask
2006-07-07 05:41:35.212 VideoOutputXv: Adaptor: 0 has flag[s]:
XvInputMask XvImageMask
2006-07-07 05:41:35.212 VideoOutputXv: Grabbed xv port 270
2006-07-07 05:41:35.212 VideoOutputXv: XVideo surface found on port 270
2006-07-07 05:41:35.212 VideoOutputXv: XVideo Format #0 is 'YUY2'
2006-07-07 05:41:35.212 VideoOutputXv: XVideo Format #1 is 'YV12'
2006-07-07 05:41:35.212 VideoOutputXv: XVideo Format #2 is 'UYVY'
2006-07-07 05:41:35.212 VideoOutputXv: XVideo Format #3 is 'I420'
2006-07-07 05:41:35.212 VideoOutputXv: Using XVideo Format 'I420'
2006-07-07 05:41:35.213 VideoOutputXv: CreateShmImages(32): XJ: (640,480)
X Error: BadMatch (invalid parameter attributes) 8
  Major opcode:  142
  Minor opcode:  14
  Resource id:  0x194
2006-07-07 05:41:35.237 VideoOutputXv: Chromakeying not possible with
this XVideo port.
2006-07-07 05:41:35.237 Image size. dispxoff 0, dispyoff: 0, dispwoff:
1024, disphoff: 768
2006-07-07 05:41:35.237 Image size. imgx 0, imgy: 5, imgw: 640, imgh: 470
2006-07-07 05:41:35.409 NVP: ClearAfterSeek(1)
2006-07-07 05:41:35.409 VideoOutputXv: ClearAfterSeek()
2006-07-07 05:41:35.409 VideoOutputXv: DiscardFrames(0)
2006-07-07 05:41:35.409 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.409 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:41:35.409 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.410 TV: StartPlayer(): took 2381 ms to start player.
2006-07-07 05:41:35.411 Using deinterlace method linearblend
2006-07-07 05:41:35.411 Using realtime priority.
2006-07-07 05:41:35.424 TV: Changing from None to WatchingPreRecorded
2006-07-07 05:41:35.431 VideoOutputXv: InputChanged(1920,1088,1.77778)
2006-07-07 05:41:35.431 VideoOutputXv: DiscardFrames(1)
2006-07-07 05:41:35.431 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.431 VideoBuffers::DiscardFrames():
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.431 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:41:35.431 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.431 VideoOutputXv: DiscardFrames(1)
2006-07-07 05:41:35.431 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.432 VideoBuffers::DiscardFrames():
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.432 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:41:35.432 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.433 VideoOutputXv: CreateShmImages(32): XJ: (1920,1088)
2006-07-07 05:41:35.511 nVidiaVideoSync: VBlank ioctl did not work,
unimplemented in this driver?
2006-07-07 05:41:35.511 DRMVideoSync: Could not open device
/dev/dri/card0, No such file or directory
2006-07-07 05:41:35.512 RTCVideoSync: Could not open /dev/rtc, No such
device.
2006-07-07 05:41:35.513 Using audio as timebase
2006-07-07 05:41:35.513 Video timing method: USleep with busy wait
2006-07-07 05:41:35.513 Refresh rate: 16665, frame interval: 33366
2006-07-07 05:41:35.513 NVP: Waiting for prebuffer.. 0
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.573 Image size. dispxoff 0, dispyoff: 96, dispwoff:
1024, disphoff: 576
2006-07-07 05:41:35.573 Image size. imgx 0, imgy: 11, imgw: 1920, imgh: 1058
2006-07-07 05:41:35.648 NVP: Waiting for prebuffer.. 1
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.677 NVP: ClearAfterSeek(1)
2006-07-07 05:41:35.677 VideoOutputXv: ClearAfterSeek()
2006-07-07 05:41:35.677 VideoOutputXv: DiscardFrames(0)
2006-07-07 05:41:35.677 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:41:35.677 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:41:35.678 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:41:35.678 detectInterlace(Detect Scan, Interlaced Scan,
29.97, 1088) ->Interlaced Scan
2006-07-07 05:41:35.678 Interlaced: Interlaced Scan  video_height: 1088
fps: 29.97
2006-07-07 05:41:35.679 Using deinterlace method linearblend
2006-07-07 05:41:35.783 NVP: Waiting for prebuffer.. 2
UUUUuUULLAAAAAAAAAAAAAAAAAAAAAA
'video_output' mean = '33324.51', std. dev. = '507.71', fps = '30.01'
...
'video_output' mean = '33358.58', std. dev. = '404.88', fps = '29.98'
2006-07-07 05:43:50.659 NVP: Changing speed to 0
2006-07-07 05:43:50.659 rate: 29.97 speed: 1 skip: 1 = interval 33366
2006-07-07 05:43:50.660 Set video sync frame interval to 33366
2006-07-07 05:43:53.459 TV: Attempting to change from
WatchingPreRecorded to None
2006-07-07 05:43:53.459 TV: StopStuff() -- begin
2006-07-07 05:43:53.459 TV: StopStuff(): stopping ring buffer[s]
2006-07-07 05:43:53.459 TV: StopStuff(): stopping player[s] (1/2)
2006-07-07 05:43:53.459 TV: StopStuff(): stopping player[s] (2/2)
2006-07-07 05:43:53.459 NVP: Exited decoder loop.
2006-07-07 05:43:53.461 VideoOutputXv: dtor
2006-07-07 05:43:53.461 VideoOutputXv: DiscardFrames(1)
2006-07-07 05:43:53.461 VideoBuffers::DiscardFrames(1):
UUUUUUUuUULUUAUUUUUUUuUUUUUUUUU
2006-07-07 05:43:53.462 VideoBuffers::DiscardFrames():
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:43:53.462 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:43:53.462 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:43:53.467 VideoOutputXv: Closing XVideo port 270
Closing PAT Filter: pid=0x0
2006-07-07 05:43:53.491 TV: StopStuff() -- end
2006-07-07 05:43:53.492 TV: Changing from WatchingPreRecorded to None
===========================



Log 3: frontend for show that works
===========================
2006-07-07 05:39:11.007 TV: Attempting to change from None to
WatchingPreRecorded
2006-07-07 05:39:11.049
RingBuf(myth://192.168.0.115:6543/1021_20060706190000.mpg):
OpenFile(myth://19
2.168.0.115:6543/1021_20060706190000.mpg, 12)
2006-07-07 05:39:11.190 reads allowed (128001 -1)
2006-07-07 05:39:11.214 reads allowed (128001 -1)
mpegts_add_stream: at pid 0x31 with type 2
mpegts_add_stream: stream #0, has id 0x31 and codec MPEG2VIDEO, type
Video at 0x82c3cb0
mpegts_add_stream: at pid 0x34 with type 129
mpegts_add_stream: stream #1, has id 0x34 and codec AC3, type Audio at
0x8eaff10
2006-07-07 05:39:11.560 reads allowed (128001 -1)
2006-07-07 05:39:11.606 reads allowed (128001 -1)
0: start_time: 6833.455 duration: 972.001
1: start_time: 6833.420 duration: 972.000
stream: start_time: 75926.892 duration: 10800.388 bitrate=11224 kb/s
2006-07-07 05:39:11.612 AFD: Stream #0, has id 0x49 codec id MPEG2VIDEO,
type Video at 0x0x82c3cb0
2006-07-07 05:39:11.612 detectInterlace(Detect Scan, Detect Scan,
59.9401, 720) ->Progressive Scan
2006-07-07 05:39:11.612 Interlaced: Progressive Scan  video_height: 720
fps: 59.9401
2006-07-07 05:39:11.612 AFD: Looking for decoder for MPEG2VIDEO
2006-07-07 05:39:11.612 AFD: Opened codec 0x92cffe0, id(MPEG2VIDEO)
type(Video)
2006-07-07 05:39:11.612 AFD: Stream #1, has id 0x52 codec id AC3, type
Audio at 0x0x8eaff10
2006-07-07 05:39:11.612 AFD: Looking for decoder for AC3
2006-07-07 05:39:11.613 AFD: Opened codec 0x8ffa140, id(AC3) type(Audio)
2006-07-07 05:39:11.613 AFD: Audio Track #1 is A/V stream #1 and has 6
channels in the English languag
e(6647399).
2006-07-07 05:39:11.613
RingBuf(myth://192.168.0.115:6543/1021_20060706190000.mpg):
CalcReadAheadThres
h(19384 KB)
                         -> threshhold(965 KB) min read(32 KB) blk
size(512 KB)
2006-07-07 05:39:11.613 AFD: Selected track 1: English AC3 5.1ch (A/V
Stream #1)
2006-07-07 05:39:11.613 AFD: Initializing audio parms from audio track #1
2006-07-07 05:39:11.613 AFD: Audio format changed
                        from id(NONE)    -1Hz -1ch   0bps    ;
id(NONE)    -1Hz -1ch   0bps
                        to   id( AC3) 48000Hz  6ch  16bps    ; id( AC3)
48000Hz  2ch  16bps
2006-07-07 05:39:11.613 Killing AudioOutputDSP
2006-07-07 05:39:11.613 Opening audio device 'default'.
2006-07-07 05:39:11.614 in SetParameters(format=2, channels=2,
rate=48000, buffer_time=500000, period_
time=125000)
2006-07-07 05:39:11.614 get_buffer_size returned 16384
2006-07-07 05:39:11.614 set_period_time_near returned 85333
2006-07-07 05:39:11.614 get_period_size returned 4096
2006-07-07 05:39:11.615 Opening mixer default
2006-07-07 05:39:11.616 Setting Master volume to 70
2006-07-07 05:39:11.616 Volume range is 0 to 31, mult=3.22581
2006-07-07 05:39:11.616 channel 0 vol set to 22
2006-07-07 05:39:11.616 Setting Master volume to 70
2006-07-07 05:39:11.616 Volume range is 0 to 31, mult=3.22581
2006-07-07 05:39:11.616 channel 1 vol set to 22
2006-07-07 05:39:11.616 Setting PCM volume to 92
2006-07-07 05:39:11.616 Volume range is 0 to 31, mult=3.22581
2006-07-07 05:39:11.616 channel 0 vol set to 29
2006-07-07 05:39:11.616 Setting PCM volume to 92
2006-07-07 05:39:11.616 Volume range is 0 to 31, mult=3.22581
2006-07-07 05:39:11.616 channel 1 vol set to 29
2006-07-07 05:39:11.617 Volume range is 0 to 31, mult=3.22581
2006-07-07 05:39:11.617 Audio fragment size: 6144
2006-07-07 05:39:11.617 Audio Stretch Factor: 1
2006-07-07 05:39:11.617 Ending reconfigure
2006-07-07 05:39:11.617 Resyncing position map. posmapStarted = 0
livetv(0) watchingRec(0)
2006-07-07 05:39:11.618 kickoffOutputAudioLoop: pid = 8142
2006-07-07 05:39:11.618 OutputAudioLoop: Play Event
2006-07-07 05:39:11.618 Broadcasting free space avail
...
2006-07-07 05:39:11.676 Broadcasting free space avail
2006-07-07 05:39:11.678 reads allowed (524289 32768)
...
2006-07-07 05:39:12.009 Broadcasting free space avail
2006-07-07 05:39:12.010 Position map filled from DB to: 647340
2006-07-07 05:39:12.012 Broadcasting free space avail
2006-07-07 05:39:12.013 SyncPositionMap prerecorded, from DB: 21579 entries
2006-07-07 05:39:12.014 SyncPositionMap, new totframes: 647340, new
length: 10799, posMap size: 21579
Input #0, mpegts, from 'myth://192.168.0.115:6543/1021_20060706190000.mpg':
  Duration: 03:00:00.3, start: 75926.891556, bitrate: 11224 kb/s
  Stream #0.0[0x31], 1/90000, 59.94 fps(r): Video: mpeg2video, yuv420p,
1280x720, 1001/60000, 19000 kb
/s
  Stream #0.1[0x34](eng), 1/90000: Audio: ac3, 48000 Hz, stereo, 384 kb/s
2006-07-07 05:39:12.014 AFD: Position map found
2006-07-07 05:39:12.014 AFD: Successfully opened decoder for file:
"myth://192.168.0.115:6543/1021_200
60706190000.mpg". novideo(0)
2006-07-07 05:39:12.015 Broadcasting free space avail
2006-07-07 05:39:12.016 VideoOutputXv: ctor
2006-07-07 05:39:12.018 Broadcasting free space avail
...
2006-07-07 05:39:12.039 Broadcasting free space avail
2006-07-07 05:39:12.039 Over/underscan. V: 0.01, H: 0, XOff: 0, YOff: 0
2006-07-07 05:39:12.042 Broadcasting free space avail
2006-07-07 05:39:12.043 Image size. dispxoff 0, dispyoff: 96, dispwoff:
1024, disphoff: 576
2006-07-07 05:39:12.043 Image size. imgx 0, imgy: 7, imgw: 1280, imgh: 706
2006-07-07 05:39:12.043 VideoOutputXv: Pixel dimensions: Screen
1024x768, window 1024x768
2006-07-07 05:39:12.043 VideoOutputXv: Estimated display dimensions:
347x260 mm Aspect: 1.33462
2006-07-07 05:39:12.043 VideoOutputXv: Estimated window dimensions:
347x260 mm Aspect: 1.33462
2006-07-07 05:39:12.044 VideoOutputXv: @ j=3 Looking for flag[s]:
XvInputMask XvImageMask
2006-07-07 05:39:12.044 VideoOutputXv: Adaptor: 0 has flag[s]:
XvInputMask XvImageMask
2006-07-07 05:39:12.044 VideoOutputXv: Grabbed xv port 270
2006-07-07 05:39:12.044 VideoOutputXv: XVideo surface found on port 270
2006-07-07 05:39:12.044 VideoOutputXv: XVideo Format #0 is 'YUY2'
2006-07-07 05:39:12.044 VideoOutputXv: XVideo Format #1 is 'YV12'
2006-07-07 05:39:12.044 VideoOutputXv: XVideo Format #2 is 'UYVY'
2006-07-07 05:39:12.044 VideoOutputXv: XVideo Format #3 is 'I420'
2006-07-07 05:39:12.044 VideoOutputXv: Using XVideo Format 'I420'
2006-07-07 05:39:12.045 Broadcasting free space avail
2006-07-07 05:39:12.045 VideoOutputXv: CreateShmImages(32): XJ: (1280,720)
2006-07-07 05:39:12.048 Broadcasting free space avail
2006-07-07 05:39:12.051 Broadcasting free space avail
...
2006-07-07 05:39:12.105 Broadcasting free space avail
X Error: BadMatch (invalid parameter attributes) 8
  Major opcode:  142
  Minor opcode:  14
  Resource id:  0x194
2006-07-07 05:39:12.105 VideoOutputXv: Chromakeying not possible with
this XVideo port.
2006-07-07 05:39:12.105 Image size. dispxoff 0, dispyoff: 96, dispwoff:
1024, disphoff: 576
2006-07-07 05:39:12.105 Image size. imgx 0, imgy: 7, imgw: 1280, imgh: 706
2006-07-07 05:39:12.107 Broadcasting free space avail
...
2006-07-07 05:39:12.284 Broadcasting free space avail
2006-07-07 05:39:12.286 NVP: ClearAfterSeek(1)
2006-07-07 05:39:12.286 VideoOutputXv: ClearAfterSeek()
2006-07-07 05:39:12.286 VideoOutputXv: DiscardFrames(0)
2006-07-07 05:39:12.286 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:39:12.286 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-07-07 05:39:12.286 VideoOutputXv: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2006-07-07 05:39:12.286 TV: StartPlayer(): took 1134 ms to start player.
2006-07-07 05:39:12.287 Using realtime priority.
2006-07-07 05:39:12.287 OutputAudioLoop: audio paused
2006-07-07 05:39:12.288 65536 bytes free on soundcard
2006-07-07 05:39:12.288 WriteAudio: Preparing 6144 bytes (1536 frames)
2006-07-07 05:39:12.290 59392 bytes free on soundcard
2006-07-07 05:39:12.291 WriteAudio: Preparing 6144 bytes (1536 frames)
2006-07-07 05:39:12.293 53248 bytes free on soundcard
2006-07-07 05:39:12.317 TV: Changing from None to WatchingPreRecorded
2006-07-07 05:39:12.386 nVidiaVideoSync: VBlank ioctl did not work,
unimplemented in this driver?
2006-07-07 05:39:12.387 DRMVideoSync: Could not open device
/dev/dri/card0, No such file or directory
2006-07-07 05:39:12.394 _AddSamples bytes=6144, used=1, free=767999,
timecode=927
2006-07-07 05:39:12.395 _AddSamples bytes=6144, used=6145, free=761855,
timecode=959
2006-07-07 05:39:12.396 _AddSamples bytes=6144, used=12289, free=755711,
timecode=991
2006-07-07 05:39:12.403 _AddSamples bytes=6144, used=18433, free=749567,
timecode=1023
2006-07-07 05:39:12.419 _AddSamples bytes=6144, used=24577, free=743423,
timecode=1055
2006-07-07 05:39:12.431 RTCVideoSync: Could not open /dev/rtc, No such
device.
2006-07-07 05:39:12.431 Using audio as timebase
2006-07-07 05:39:12.431 Video timing method: USleep with busy wait
2006-07-07 05:39:12.431 Refresh rate: 16665, frame interval: 16683
2006-07-07 05:39:12.431 NVP: Waiting for prebuffer.. 0
UuUULULAAAAAAAAAAAAAAAAAAAAAAAA
2006-07-07 05:39:12.436 _AddSamples bytes=6144, used=30721, free=737279,
timecode=1087
2006-07-07 05:39:12.450 _AddSamples bytes=6144, used=36865, free=731135,
timecode=1119
2006-07-07 05:39:12.462 _AddSamples bytes=6144, used=43009, free=724991,
timecode=1151
2006-07-07 05:39:12.474 _AddSamples bytes=6144, used=49153, free=718847,
timecode=1183
2006-07-07 05:39:12.477 OutputAudioLoop: Play Event
2006-07-07 05:39:12.477 Broadcasting free space avail
2006-07-07 05:39:12.477 WriteAudio: Preparing 6144 bytes (1536 frames)
...
===========================



---



More information about the mythtv-users mailing list