[mythtv-users] Anybody using analog "soft encoder" tuners under 0.24 ?
Mark Lord
mythtv at rtr.ca
Tue Apr 5 21:45:09 UTC 2011
And here is the frontend log, with -v playback,channel:
17:34:43.398 mythfrontend version: [Unknown] www.mythtv.org
17:34:43.399 Using runtime prefix = /usr
17:34:43.399 Using configuration directory = /home/mlord/.mythtv
17:34:43.401 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
17:34:44.016 Empty LocalHostName.
17:34:44.016 Using localhost value of zbox
17:34:44.052 New DB connection, total: 1
17:34:44.058 Connected to database 'mythconverg' at host: localhost
17:34:44.072 Closing DB connection named 'DBManager0'
17:34:44.073 Connected to database 'mythconverg' at host: localhost
17:34:44.077 Current locale EN_CA
17:34:44.077 Reading locale defaults from /usr/share/mythtv//locales/en_ca.xml
17:34:44.298 ScreenSaverX11Private: XScreenSaver support enabled
17:34:44.298 ScreenSaverX11Private: Gnome screen saver support enabled
17:34:44.300 DPMS is disabled.
17:34:44.363 Desktop video mode: 1920x1200 59.950 Hz
17:34:44.399 max_width: 1920 max_height: 1200
17:34:44.402 user: 1000 effective user: 1000 before privileged thread
17:34:44.403 user: 1000 effective user: 1000 after privileged thread
17:34:44.403 user: 1000 effective user: 1000 run_priv_thread
17:34:44.404 Enabled verbose msgs: important general playback channel
17:34:44.411 Loading en_us translation for module mythfrontend
17:34:44.433 LIRC: Successfully initialized '/var/run/lirc/lircd' using
'/home/mlord/.mythtv/lircrc' config
17:34:44.500 Using Frameless Window
17:34:44.500 Using Full Screen Window
17:34:45.508 Using the Qt painter
17:34:45.951 Current MythTV Schema Version (DBSchemaVer): 1264
17:34:45.953 VDP: decoder<->render support: ffmpeg null xlib xshm xv-blit
opengl vdpau
17:34:45.954 VDP: decoder<->render support: xvmc xvmc-blit
17:34:45.954 VDP: decoder<->render support: xvmc-vld xvmc-blit
17:34:45.954 VDP: decoder<->render support: vdpau vdpau
17:34:45.954 VDP: decoder<->render support: libmpeg2 null xlib xshm xv-blit
opengl vdpau
17:34:45.960 VDP: Ignoring profile item 4 (OSD Renderer opengl is not supported
w/renderer xvmc-blit (supported: chromakey,ia44blend))
17:34:45.963 VDP: Ignoring profile item 2 (renderer quartz-blit is not supported
w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.965 VDP: Ignoring profile item 8 (decoder ivtv is not supported
(supported: ffmpeg,xvmc,xvmc-vld,vdpau,libmpeg2))
17:34:45.969 VDP: Ignoring profile item 15 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.969 VDP: Ignoring profile item 16 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.971 VDP: Ignoring profile item 19 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.972 VDP: Ignoring profile item 20 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.974 VDP: Ignoring profile item 23 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:45.974 VDP: Ignoring profile item 24 (renderer quartz-blit is not
supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
17:34:47.167 Pulse: PulseAudio suspend OK
17:34:47.461 Pulse: PulseAudio resume OK
17:34:47.734 Registering Internal as a media playback plugin.
17:34:47.801 Loading en_us translation for module mytharchive
17:34:47.840 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1038
17:34:47.895 Loading en_us translation for module mythvideo
17:34:48.310 Found mainmenu.xml for theme 'Mythbuntu'
17:34:48.890 MythCoreContext: Connecting to backend server: 127.0.0.1:6543 (try
1 of 1)
17:34:48.893 Using protocol version 63
17:34:51.838 TV: StartTV() -- begin
17:34:51.839 TV: ctor -- begin
17:34:51.854 TV: ctor -- end
17:34:51.854 TV: Init -- begin
17:34:51.860 TV: DrawUnusedRects() -- begin
17:34:51.860 TV: DrawUnusedRects() -- end
17:34:51.860 TV: DrawUnusedRects() -- begin
17:34:51.861 TV: DrawUnusedRects() -- end
17:34:51.984 TV: DrawUnusedRects() -- begin
17:34:51.984 TV: DrawUnusedRects() -- end
17:34:51.985 TV: Init -- end
17:34:51.989 TV: tv->LiveTV() -- begin
17:34:51.998 TV: HandleStateChange(0) -- begin
17:34:51.999 TV: Attempting to change from None to WatchingLiveTV
17:34:51.999 MythCoreContext: Connecting to backend server: 127.0.0.1:6543 (try
1 of 1)
17:34:52.000 Using protocol version 63
17:34:52.008 IsTunable(7009)
17:34:52.014 IsTunable(7009) -> true
17:34:52.019 Spawning LiveTV Recorder -- begin
17:34:53.426 Spawning LiveTV Recorder -- end
17:34:53.428 LiveTVChain(live-zbox-2011-04-05T17:34:51): ReloadAll(): Added new
recording
17:34:53.439 We have a
playbackURL(/var/lib/mythtv/livetv/7009_20110405173452.nuv) & cardtype(DUMMY)
17:34:53.439 We have a RingBuffer
17:34:53.440 TV: StartRecorder(): took 1 ms to start recorder.
17:34:53.441 TV: StartPlayer(0, WatchingLiveTV, main) -- begin
17:34:53.441 TV: Elapsed time since TV constructor was called: 1602 ms
17:34:53.607 playCtx: Output filters for this channel are: ''
17:34:53.867 Pulse: PulseAudio suspend OK
17:34:53.977 Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 25, 576)
->Interlaced Scan
17:34:53.985 VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl,vdpau
17:34:53.985 VideoOutput: Allowed renderers (filt: dummy):
xlib,xshm,xv-blit,opengl,vdpau
17:34:53.989 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(3) skiploop(enabled)
rend(vdpau) osd(vdpau) osdfade(disabled)
deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaubuffersize=42)
17:34:53.989 VDP: LoadBestPreferences(2048x2048, 0)
17:34:53.989 VDP: LoadBestPreferences(2048x2048, 60)
17:34:53.989 VDP: LoadBestPreferences(720x576, 60)
17:34:53.989 VideoOutput: Preferred renderer: vdpau
17:34:53.990 VideoOutput: Trying video renderer: 'vdpau'
17:34:54.011 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(3) skiploop(enabled)
rend(vdpau) osd(vdpau) osdfade(disabled)
deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaubuffersize=42)
17:34:54.011 VDP: LoadBestPreferences(2048x2048, 0)
17:34:54.011 VDP: LoadBestPreferences(2048x2048, 60)
17:34:54.011 VideoOutWindow::SetPIPState. pip_state: 0]
17:34:54.011 VDP: LoadBestPreferences(2048x2048, 25)
17:34:54.011 Display Rect left: 0, top: 0, width: 1920, height: 1200, aspect:
1.33333
17:34:54.012 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.3333
17:34:54.012 VDP: LoadBestPreferences(720x576, 25)
17:34:54.012 Display Rect left: 0, top: 0, width: 1920, height: 1200, aspect:
1.33333
17:34:54.012 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.3333
17:34:54.012 VDP: SetVideoRenderer(vdpau)
17:34:54.012 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
17:34:54.014 VideoOutput: Pixel dimensions: Screen 1920x1200, window 1920x1200
17:34:54.014 VideoOutput: Actual display dimensions: 554x342 mm Aspect: 1.61988
17:34:54.014 VideoOutput: Estimated window dimensions: 554x342 mm Aspect: 1.61988
17:34:54.014 VidOutVDPAU: VDPAU video buffer size: 42 (default 17)
17:34:54.089 VDPAU: Created 2 output surfaces.
17:34:54.090 VDPAU: Set colorkey to 0x20202
17:34:54.090 VDPAU: Version 1
17:34:54.090 VDPAU: Information NVIDIA VDPAU Driver Shared Library 260.19.44
Sun Feb 27 22:59:20 PST 2011
17:34:54.090 VDPAU: HQ scaling level 1 of 9 available.
17:34:54.090 VDPAU: MPEG4 hardware acceleration supported.
17:34:54.090 VDPAU: Created VDPAU render device 1920x1200
17:34:54.090 VidOutVDPAU: Created VDPAU osd (1920x1200)
17:34:54.135 VidOutVDPAU: PictureAttributes: Brightness, Contrast, Colour, Hue,
17:34:54.149 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:34:54.150 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.3333
17:34:54.150 VidOutVDPAU: Created VDPAU context (software decode)
17:34:54.153 Over/underscan. V: 0, H: 0
17:34:54.153 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:34:54.153 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.3333
17:34:54.153 FilterManager: GetFilterInfo(convert) returning: 0x0
17:34:54.153 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:34:54.156 Player(0): Decoder thread starting.
17:34:54.183 OSD: Loaded window osd_message
17:34:54.193 OSD: Loaded window osd_input
17:34:54.242 OSD: Loaded window program_info
17:34:54.254 OSD: Loaded window browse_info
17:34:54.266 OSD: Loaded window osd_status
17:34:54.279 OSD: Loaded window osd_program_editor
17:34:54.279 OSD: Loaded OSD: size 1920x1200 offset 0+0
17:34:54.284 Player(0): ClearAfterSeek(0)
17:34:54.286 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
17:34:54.287 VidOutVDPAU: Enabled deinterlacing.
17:34:54.287 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such
file or directory
17:34:54.288 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied.
17:34:54.288 Player(0): Play speed: rate: 25 speed: 1 skip: 1 => new interval 40000
17:34:54.290 Player(0): Video timing method: USleep with busy wait
17:34:54.290 Player(0): Display Refresh Rate: 59.952 Video Frame Rate: 25.000
17:34:54.291 playCtx: StartPlaying(): took 0 ms to start player.
17:34:54.291 TV: StartPlayer(0, WatchingLiveTV, main) -- end ok
17:34:54.291 TV: Changing from None to WatchingLiveTV
17:34:54.291 TV: State is LiveTV & mctx == ctx
17:34:54.294 TV: UpdateOSDInput done
17:34:54.294 TV: UpdateLCD done
17:34:54.294 TV: ITVRestart done
17:34:54.313 TV: DrawUnusedRects() -- begin
17:34:54.313 TV: DrawUnusedRects() -- end
17:34:54.313 TV: HandleStateChange(0) -- end
17:34:54.314 TV: tv->LiveTV() -- end
17:34:54.315 TV: StartTV -- process events begin
17:34:54.347 ScreenSaverX11Private: ResetTimer -- begin
17:34:54.348 ScreenSaverX11Private: StopTimer
17:34:54.349 ScreenSaverX11Private: StartTimer
17:34:54.349 ScreenSaverX11Private: ResetTimer -- end
17:34:54.349 TV: DrawUnusedRects() -- begin
17:34:54.349 TV: DrawUnusedRects() -- end
17:34:54.351 LiveTVChain(live-zbox-2011-04-05T17:34:51): ReloadAll(): Added new
recording
17:34:54.358 LiveTVChain(live-zbox-2011-04-05T17:34:51): SwitchTo(1)
17:34:54.358 LiveTVChain(live-zbox-2011-04-05T17:34:51): Entry at 1:
'7009_20110405173453'
17:34:54.358 Player(0): JumpToProgram - start
17:34:54.366 playCtx: Output filters for this channel are: ''
17:34:54.366 FilterManager: GetFilterInfo(convert) returning: 0x0
17:34:54.366 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:34:54.366 Player(0): Play speed: rate: 25 speed: 0 skip: 0 => new interval 40000
17:34:54.368 VDP: GetFilteredDeint(vdpauadvanced) : vdpau -> 'vdpauadvanced'
17:34:54.369 VidOutVDPAU: Enabled deinterlacing.
17:34:54.372 RingBuf(/var/lib/mythtv/livetv/7009_20110405173452.nuv):
OpenFile(/var/lib/mythtv/livetv/7009_20110405173453.nuv, 10000 ms)
17:34:54.380 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(3) skiploop(enabled)
rend(vdpau) osd(vdpau) osdfade(disabled)
deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaubuffersize=42)
17:34:54.380 VDP: LoadBestPreferences(2048x2048, 0)
17:34:54.381 VDP: LoadBestPreferences(2048x2048, 60)
17:34:54.381 VDP: LoadBestPreferences(720x480, 60)
17:34:54.381 VDP: LoadBestPreferences(720x576, 29.97)
17:34:54.381 VidOutVDPAU: InputChanged(720,480,1.33333) 'None'->'NUV RTjpeg'
17:34:54.382 VidOutVDPAU: DiscardFrames(1)
17:34:54.382 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
17:34:54.383 VideoBuffers::DiscardFrames():
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:34:54.383 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
17:34:54.383 VidOutVDPAU: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:34:54.384 VDPAU Painter: Clearing VDPAU painter cache.
17:34:54.384 MythPainter: 2 images not yet de-allocated.
17:34:54.418 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:34:54.418 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:34:54.418 VDP: LoadBestPreferences(720x480, 29.97)
17:34:54.419 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:34:54.419 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:34:54.419 VDP: SetVideoRenderer(vdpau)
17:34:54.419 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
17:34:54.424 VideoOutput: Pixel dimensions: Screen 1920x1200, window 1920x1200
17:34:54.424 VideoOutput: Actual display dimensions: 554x342 mm Aspect: 1.61988
17:34:54.424 VideoOutput: Estimated window dimensions: 554x342 mm Aspect: 1.61988
17:34:54.425 VidOutVDPAU: VDPAU video buffer size: 42 (default 17)
17:34:54.591 VDPAU: Created 2 output surfaces.
17:34:54.591 VDPAU: Set colorkey to 0x20202
17:34:54.591 VDPAU: Created VDPAU render device 1920x1200
17:34:54.591 VidOutVDPAU: Created VDPAU osd (1920x1200)
17:34:54.633 VidOutVDPAU: PictureAttributes: Brightness, Contrast, Colour, Hue,
17:34:54.642 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:34:54.642 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:34:54.642 VidOutVDPAU: Created VDPAU context (software decode)
17:34:54.642 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
17:34:54.644 VidOutVDPAU: Enabled deinterlacing.
17:34:54.644 Player(0): ClearAfterSeek(1)
17:34:54.644 VidOutVDPAU: ClearAfterSeek()
17:34:54.644 VidOutVDPAU: DiscardFrames(0)
17:34:54.644 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
17:34:54.644 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
17:34:54.644 VidOutVDPAU: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:34:54.645 FilterManager: GetFilterInfo(convert) returning: 0x0
17:34:54.645 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:34:54.645 Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 29.97,
480) ->Interlaced Scan
17:34:54.645 Player(0): Enabled deinterlacing
17:34:54.768 Pulse: PulseAudio resume OK
17:34:55.068 Pulse: PulseAudio suspend OK
17:34:55.175 AO: Opening audio device 'hw:CARD=Intel,DEV=0' ch 2(2) sr 48000 sf
signed 32 bit reenc 0
17:34:55.183 AudioPlayer: Enabling Audio
17:34:55.183 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
17:34:55.185 Dec: Position map filled from DB to: 0
17:34:55.186 Dec: SyncPositionMap watchingrecording, from DB: 1 entries
17:34:55.186 Player(0): Filling position map from 1 to end
17:34:55.192 Dec: Position map filled from Encoder to: 1
17:34:55.193 Dec: SyncPositionMap watchingrecording total: 2 entries
17:34:55.193 Dec: SyncPositionMap, new totframes: 30, new length: 1, posMap size: 2
17:34:55.200 Player(0): Play( 1.0, normal 1, unpause audio 1)
17:34:55.201 Player(0): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval
33366
17:34:55.201 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
17:34:55.201 Player(0): Stretch Factor 1, allow passthru
17:34:55.202 Player(0): JumpToProgram - end
17:34:55.202 Player(0): Waiting for video buffers...
17:34:55.203 Dec: Position map filled from DB to: 0
17:34:55.204 Dec: SyncPositionMap watchingrecording, from DB: 1 entries
17:34:55.204 Player(0): Filling position map from 1 to end
17:34:55.209 Dec: Position map filled from Encoder to: 1
17:34:55.209 Dec: SyncPositionMap watchingrecording total: 2 entries
17:34:55.249 Detect Letterbox: YV12 frame format detected
17:34:55.249 Detect Letterbox: Strange frame number -1
17:34:55.259 VDPAU: Added 2 output surfaces (total 4, max 4)
17:34:55.779 Player(0): Video is 3.67515 frames ahead of audio,
doubling video frame interval to slow down.
17:34:55.845 Player(0): Video is 4.77936 frames ahead of audio,
doubling video frame interval to slow down.
17:34:55.912 Player(0): Video is 5.46517 frames ahead of audio,
doubling video frame interval to slow down.
17:34:55.979 Player(0): Video is 5.77723 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.045 Player(0): Video is 5.68159 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.112 Player(0): Video is 5.39259 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.179 Player(0): Video is 4.97351 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.246 Player(0): Video is 4.32953 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.312 Player(0): Video is 3.64425 frames ahead of audio,
doubling video frame interval to slow down.
17:34:56.446 Player(0): Video is 3.40751 frames ahead of audio,
doubling video frame interval to slow down.
Somebody didn't prefix logs with date/time for these two:
'video_output' mean = '39832.53', std. dev. = '19450.41', fps = '25.11'
'video_output' mean = '34363.71', std. dev. = '11365.04', fps = '29.10'
Changing channels now in LiveTV, from old=9 to new=24:
17:35:05.455 TV: CommitQueuedInput() livetv(1) qchannum(24) qchanid(0)
17:35:05.456 TV: ChangeChannel(0, '24')
17:35:05.475 TV: PauseLiveTV() player ctx 0
17:35:06.856 TV: UnpauseLiveTV() player ctx 0
17:35:06.858 LiveTVChain(live-zbox-2011-04-05T17:34:51): ReloadAll(): Added new
recording
17:35:06.869 LiveTVChain(live-zbox-2011-04-05T17:34:51): SwitchTo(-1)
17:35:06.869 LiveTVChain(live-zbox-2011-04-05T17:34:51): Entry at 2:
'7024_20110405173505'
17:35:06.869 Player(0): Play( 1.0, normal 1, unpause audio 0)
17:35:06.938 Player(0): JumpToProgram - start
17:35:06.949 playCtx: Output filters for this channel are: ''
17:35:06.949 FilterManager: GetFilterInfo(convert) returning: 0x0
17:35:06.949 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:35:06.995 LiveTVChain(live-zbox-2011-04-05T17:34:51): SwitchTo(2)
17:35:06.995 LiveTVChain(live-zbox-2011-04-05T17:34:51): Entry at 2:
'7024_20110405173505'
17:35:07.000 Player(0): Play speed: rate: 29.97 speed: 0 skip: 0 => new interval
33366
17:35:07.002 VDP: GetFilteredDeint(vdpauadvanced) : vdpau -> 'vdpauadvanced'
17:35:07.003 VidOutVDPAU: Enabled deinterlacing.
17:35:07.004 Player(0): ClearAfterSeek(1)
17:35:07.004 VidOutVDPAU: ClearAfterSeek()
17:35:07.004 VidOutVDPAU: DiscardFrames(0)
17:35:07.005 VideoBuffers::DiscardFrames(0):
UUUUUUUUUUUUUUUUUUUUUUUUUUAUUUUUUUUUUUUUUU
17:35:07.005 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
17:35:07.005 VidOutVDPAU: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:35:07.270 LiveTVChain(live-zbox-2011-04-05T17:34:51): ReloadAll(): Added new
recording
17:35:07.275 LiveTVChain(live-zbox-2011-04-05T17:34:51): SwitchTo(3)
17:35:07.275 LiveTVChain(live-zbox-2011-04-05T17:34:51): Entry at 3:
'7024_20110405173507'
17:35:07.275 Player(0): JumpToProgram - start
17:35:07.287 playCtx: Output filters for this channel are: ''
17:35:07.287 FilterManager: GetFilterInfo(convert) returning: 0x0
17:35:07.287 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:35:07.287 Player(0): Play speed: rate: 29.97 speed: 0 skip: 0 => new interval
33366
17:35:07.290 RingBuf(/var/lib/mythtv/livetv/7009_20110405173453.nuv):
OpenFile(/var/lib/mythtv/livetv/7024_20110405173507.nuv, 10000 ms)
17:35:07.302 RingBuf(/var/lib/mythtv/livetv/7024_20110405173507.nuv) Warning:
Not starting read ahead thread, already running
17:35:07.752 AFD: Stream #0, has id 0x0 codec id MP2, type Audio, bitrate 128000
at 0x7f454c0b1100
17:35:07.753 AFD: codec MP2 has 2 channels
17:35:07.753 AFD: Looking for decoder for MP2
17:35:07.753 AFD: Opened codec 0x7f454c0da1c0, id(MP2) type(Audio)
17:35:07.756 VidOutVDPAU: InputChanged(720,480,1.33333) 'NUV RTjpeg'->'None'
17:35:07.756 VidOutVDPAU: DiscardFrames(1)
17:35:07.757 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
17:35:07.757 VideoBuffers::DiscardFrames():
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:35:07.757 VideoBuffers::DiscardFrames(1):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
17:35:07.757 VidOutVDPAU: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:35:07.759 VDPAU Painter: Clearing VDPAU painter cache.
17:35:07.763 MythPainter: 3 images not yet de-allocated.
17:35:07.809 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:35:07.810 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:35:07.810 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:35:07.810 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:35:07.810 VDP: SetVideoRenderer(vdpau)
17:35:07.810 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
17:35:07.815 VideoOutput: Pixel dimensions: Screen 1920x1200, window 1920x1200
17:35:07.815 VideoOutput: Actual display dimensions: 554x342 mm Aspect: 1.61988
17:35:07.815 VideoOutput: Estimated window dimensions: 554x342 mm Aspect: 1.61988
17:35:07.815 VidOutVDPAU: VDPAU video buffer size: 42 (default 17)
17:35:07.867 VDPAU: Created 2 output surfaces.
17:35:07.867 VDPAU: Set colorkey to 0x20202
17:35:07.867 VDPAU: Created VDPAU render device 1920x1200
17:35:07.867 VidOutVDPAU: Created VDPAU osd (1920x1200)
17:35:07.906 VidOutVDPAU: PictureAttributes: Brightness, Contrast, Colour, Hue,
17:35:07.915 Display Rect left: 170, top: 0, width: 1580, height: 1200, aspect:
1.61988
17:35:07.916 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
17:35:07.916 VidOutVDPAU: Created VDPAU context (software decode)
17:35:07.916 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
17:35:07.917 VidOutVDPAU: Enabled deinterlacing.
17:35:07.917 Player(0): ClearAfterSeek(1)
17:35:07.918 VidOutVDPAU: ClearAfterSeek()
17:35:07.918 VidOutVDPAU: DiscardFrames(0)
17:35:07.918 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
17:35:07.918 VideoBuffers::DiscardFrames(0):
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
17:35:07.918 VidOutVDPAU: DiscardFrames() 3:
AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
17:35:07.918 FilterManager: GetFilterInfo(convert) returning: 0x0
17:35:07.918 Player(0): LoadFilters('vdpaubuffersize=42'..) -> 0x0
17:35:07.919 Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 29.97,
480) ->Interlaced Scan
17:35:07.919 Dec: Trying to select track (w/lang)
17:35:07.919 Dec: Selecting first track
17:35:07.919 Dec: Selected track #1 in the Unknown language(0)
17:35:07.919 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
17:35:07.923 Dec: SyncPositionMap watchingrecording, from DB: 0 entries
17:35:07.923 Dec: SyncPositionMap watchingrecording no entries from encoder, try DB
17:35:07.926 Dec: SyncPositionMap watchingrecording total: 0 entries
17:35:07.926 AFD: Successfully opened decoder for file:
"/var/lib/mythtv/livetv/7024_20110405173507.nuv". novideo(0)
17:35:07.931 AFD: Resetting byte context eof (livetv 1 was eof 0)
17:35:08.038 Player(0): Play( 1.0, normal 1, unpause audio 1)
17:35:08.039 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
17:35:08.042 Dec: SyncPositionMap watchingrecording, from DB: 0 entries
17:35:08.042 Dec: SyncPositionMap watchingrecording no entries from encoder, try DB
17:35:08.046 Dec: SyncPositionMap watchingrecording total: 0 entries
17:35:08.047 Player(0): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval
33366
17:35:08.048 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
17:35:08.048 [mp2 @ 0x7f4564247620]Header missing
17:35:08.049 AFD Error: Unknown audio decoding error
17:35:08.050 VidOutVDPAU: Enabled deinterlacing.
17:35:08.050 Player(0): Stretch Factor 1, allow passthru
17:35:08.050 Player(0): JumpToProgram - end
17:35:08.050 Player(0): Waiting for video buffers...
17:35:08.051 [mp2 @ 0x7f4564247620]Header missing
17:35:08.052 AFD Error: Unknown audio decoding error
17:35:08.052 [mp2 @ 0x7f4564247620]Header missing
17:35:08.052 AFD Error: Unknown audio decoding error
17:35:08.052 [mp2 @ 0x7f4564247620]Header missing
Tens of thousands of duplicate errors deleted from the log prior to posting.
17:35:25.350 AFD Error: Unknown audio decoding error
17:35:25.351 [mp2 @ 0x7f4564247620]Header missing
17:35:25.351 AFD Error: Unknown audio decoding error
17:35:25.492 Pulse: PulseAudio resume OK
17:35:25.493 Player(0): StopPlaying - end
17:35:25.493 TV: StopStuff(): stopping ring buffer
17:35:25.494 TV: StopStuff(): stopping player
17:35:25.494 TV: StopStuff(): stopping recorder
17:35:25.792 Pulse: PulseAudio suspend OK
17:35:25.859 TV: StopStuff() -- end
17:35:25.860 TV: Changing from WatchingLiveTV to None
17:35:25.861 TV: HandleStateChange(0) -- end
17:35:25.862 ScreenSaverX11Private: StopTimer
17:35:25.863 TV: HandleStateChange(0) -- begin
17:35:25.864 TV: Attempting to change from None to None
17:35:25.865 TV: HandleStateChange(0) -- end
17:35:25.868 TV: StartTV -- process events end
17:35:25.872 TV: tv->LiveTV() -- begin
17:35:25.883 TV: HandleStateChange(0) -- begin
17:35:25.883 TV: Attempting to change from None to WatchingLiveTV
17:35:25.884 MythCoreContext: Connecting to backend server: 127.0.0.1:6543 (try
1 of 1)
17:35:25.885 Using protocol version 63
17:35:25.894 IsTunable(7024)
17:35:25.901 IsTunable(7024) -> true
17:35:25.908 Spawning LiveTV Recorder -- begin
17:35:25.909 AO: Resampling from 32 kHz to 44 kHz with quality medium
17:35:25.911 AO: Opening audio device 'hw:CARD=Intel,DEV=0' ch 2(1) sr 44100 sf
signed 32 bit reenc 0
17:35:25.916 AudioPlayer: Enabling Audio
17:35:25.917 [mp2 @ 0x7f4564247620]Header missing
17:35:25.917 AFD Error: Unknown audio decoding error
17:35:25.917 [mp2 @ 0x7f4564247620]Header missing
17:35:25.917 AFD Error: Unknown audio decoding error
17:35:25.917 Player(0): Decoder thread exiting.
17:35:27.128 Spawning LiveTV Recorder -- end
17:35:27.130 LiveTVChain(live-zbox-2011-04-05T17:35:25): ReloadAll(): Added new
recording
17:35:27.140 We have a
playbackURL(/var/lib/mythtv/livetv/7024_20110405173525.nuv) & cardtype(DUMMY)
17:35:27.140 We have a RingBuffer
17:35:27.141 TV: StartRecorder(): took 1 ms to start recorder.
17:35:27.142 TV: StartPlayer(0, WatchingLiveTV, main) -- begin
17:35:27.142 TV: Elapsed time since TV constructor was called: 35303 ms
17:35:27.142 playCtx, Error: Attempting to setup a player, but it already exists.
17:35:27.142 TV: StartPlayer(0, WatchingLiveTV, main) -- end error
17:35:27.142 TV Error: LiveTV not successfully started
17:35:27.143 TV: DrawUnusedRects() -- begin
17:35:27.143 TV: DrawUnusedRects() -- end
17:35:27.143 TV: HandleStateChange(0) -- end
17:35:27.143 TV: tv->LiveTV() -- end
17:35:27.143 TV: StartTV -- process events begin
17:35:27.144 ScreenSaverX11Private: StopTimer
17:35:27.145 ScreenSaverX11Private: ResetTimer -- begin
17:35:27.145 ScreenSaverX11Private: StopTimer
17:35:27.145 ScreenSaverX11Private: StartTimer
17:35:27.146 ScreenSaverX11Private: ResetTimer -- end
17:35:27.146 TV: StartTV -- process events end
17:35:27.146 TV: StartTV -- process events 2 begin
17:35:27.146 TV: StartTV -- process events 2 end
17:35:27.146 TV::~TV() -- begin
17:35:27.147 TV: DrawUnusedRects() -- begin
17:35:27.147 TV: DrawUnusedRects() -- end
17:35:27.148 TV: DrawUnusedRects() -- begin
17:35:27.148 TV: DrawUnusedRects() -- end
17:35:27.158 TV::~TV() -- lock
17:35:27.159 Player(0): StopPlaying - begin
17:35:27.159 Player(0): Exited decoder loop.
17:35:27.294 Pulse: PulseAudio resume OK
17:35:27.294 Player(0): StopPlaying - end
17:35:27.401 TV::~TV() -- end
17:35:27.407 TV: StartTV -- end
17:35:32.881 Pulse: Cleaning up PulseHandler
17:35:32.882 Deleting UPnP client...
More information about the mythtv-users
mailing list