Ticket #5793: log

File log, 29.1 KB (added by Simon Kenyon <simon@…>, 15 years ago)

log of frontend running in a windows with -v playback

Line 
12009-05-19 23:05:31.167 mythfrontend version: trunk [exported] www.mythtv.org
22009-05-19 23:05:31.228 Using runtime prefix = /usr
32009-05-19 23:05:31.816 Using localhost value of cozumel-windowed
42009-05-19 23:05:31.922 Cannot find default UPnP backend
52009-05-19 23:05:31.922 Testing network connectivity to sanfrancisco.koala.ie
62009-05-19 23:05:31.935 New DB connection, total: 1
72009-05-19 23:05:31.940 Connected to database 'mythconverg' at host: sanfrancisco.koala.ie
82009-05-19 23:05:31.941 Closing DB connection named 'DBManager0'
92009-05-19 23:05:32.016 ScreenSaverX11Private: Gnome screen saver support enabled
102009-05-19 23:05:32.020 DPMS is disabled.
112009-05-19 23:05:32.029 Primary screen: 0.
122009-05-19 23:05:32.039 Connected to database 'mythconverg' at host: sanfrancisco.koala.ie
132009-05-19 23:05:32.041 Running in a window
142009-05-19 23:05:32.042 Using screen 0, 1920x1153 at 0,0
152009-05-19 23:05:32.171 MythUI Image Cache size set to 20971520 bytes
162009-05-19 23:05:32.171 Setting 'UseFixedWindowSize' being forced to '0'
172009-05-19 23:05:32.172 user: 1000 effective user: 1000 before privileged thread
182009-05-19 23:05:32.172 user: 1000 effective user: 1000 run_priv_thread
192009-05-19 23:05:32.172 user: 1000 effective user: 1000 after privileged thread
202009-05-19 23:05:32.172 Enabled verbose msgs:  important general playback
212009-05-19 23:05:32.371 The theme (defaultmenu) is missing a themeinfo.xml file
222009-05-19 23:05:33.953 The theme (defaultmenu) is missing a themeinfo.xml file
232009-05-19 23:05:34.561 max_width: 1920 max_height: 1200
242009-05-19 23:05:34.896 Primary screen: 0.
252009-05-19 23:05:34.897 Running in a window
262009-05-19 23:05:34.897 Using screen 0, 1920x1153 at 0,0
272009-05-19 23:05:34.898 Using theme base resolution of 800x600
282009-05-19 23:05:34.911 LIRC: Successfully initialized '/dev/lircd' using '/home/simon/.lircrc' config
292009-05-19 23:05:34.911 JoystickMenuThread Error: Joystick disabled - Failed to read /home/simon/.mythtv-window/joystickmenurc
302009-05-19 23:05:35.242 Using the Qt painter
312009-05-19 23:05:35.606 Loading base theme from /usr/share/mythtv/themes/MythCenter/base.xml
322009-05-19 23:05:36.468 Loading base theme from /usr/share/mythtv/themes/default/base.xml
332009-05-19 23:05:36.523 Current Schema Version: 1234
342009-05-19 23:05:36.542 Connecting to backend server: 195.7.61.35:6543 (try 1 of 5)
352009-05-19 23:05:36.543 Using protocol version 45
362009-05-19 23:05:36.835 Registering Internal as a media playback plugin.
372009-05-19 23:05:36.882 Cannot load language en_gb for module mytharchive
382009-05-19 23:05:36.884 Cannot load language en_gb for module mythbrowser
392009-05-19 23:05:36.891 Cannot load language en_gb for module mythbookmarkmanager
402009-05-19 23:05:36.921 Cannot load language en_gb for module mythflix
412009-05-19 23:05:37.036 MonitorRegisterExtensions(0x100, gif,jpg,png)
422009-05-19 23:05:37.042 Cannot load language en_gb for module mythgallery
432009-05-19 23:05:37.072 Cannot load language en_gb for module mythgame
442009-05-19 23:05:37.077 Cannot load language en_gb for module mythmovies
452009-05-19 23:05:37.228 MonitorRegisterExtensions(0x40, ogg,mp3,aac,flac)
462009-05-19 23:05:37.236 Cannot load language en_gb for module mythmusic
472009-05-19 23:05:37.256 Cannot load language en_gb for module mythnews
482009-05-19 23:05:37.349 Cannot load language en_gb for module mythvideo
492009-05-19 23:05:37.384 Cannot load language en_gb for module mythweather
502009-05-19 23:05:37.396 Cannot load language en_gb for module mythzoneminder
512009-05-19 23:05:39.183 Loading window theme from /usr/share/mythtv/themes/MythCenter/menu-ui.xml
522009-05-19 23:05:39.848 Loading menu theme from /usr/share/mythtv/themes/classic//mainmenu.xml
532009-05-19 23:05:39.853 Found mainmenu.xml for theme 'MythCenter'
542009-05-19 23:05:42.813 Loading menu theme from /usr/share/mythtv/themes/classic//tvmenu.xml
552009-05-19 23:05:43.472 TV: StartTV() -- begin
562009-05-19 23:05:43.473 TV: ctor
572009-05-19 23:05:43.506 New DB connection, total: 2
582009-05-19 23:05:43.508 Connected to database 'mythconverg' at host: sanfrancisco.koala.ie
592009-05-19 23:05:43.561 TV: tv->LiveTV() -- begin
602009-05-19 23:05:43.574 TV: tv->LiveTV() -- end
612009-05-19 23:05:43.574 TV: StartTV -- process events begin
622009-05-19 23:05:43.595 TV: HandleStateChange(0) -- begin
632009-05-19 23:05:43.595 TV: Attempting to change from None to Watching WatchingLiveTV
642009-05-19 23:05:43.596 Using protocol version 45
652009-05-19 23:05:43.597 Spawning LiveTV Recorder -- begin
662009-05-19 23:05:45.049 Spawning LiveTV Recorder -- end
672009-05-19 23:05:45.050 LiveTVChain(live-cozumel-windowed-2009-05-19T23:05:43): ReloadAll(): Added new recording
682009-05-19 23:05:45.069 We have a playbackURL(myth://195.7.61.35:6543/7319_20090519230543.mpg) & cardtype(DUMMY)
692009-05-19 23:05:45.069 We have a RingBuffer
702009-05-19 23:05:45.069 TV: StartRecorder(): took 0 ms to start recorder.
712009-05-19 23:05:45.070 TV: StartPlayer(0, Watching WatchingLiveTV, main) -- begin
722009-05-19 23:05:45.090 detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
732009-05-19 23:05:45.094 NVP(0): Disabling Audio, params(-1,2,44100)
742009-05-19 23:05:45.112 VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl
752009-05-19 23:05:45.113 VideoOutput: Allowed renderers (filt: dummy): xlib,xshm,xv-blit,opengl
762009-05-19 23:05:45.117 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
772009-05-19 23:05:45.117 VDP: LoadBestPreferences(2048x2048, 0)
782009-05-19 23:05:45.117 VDP: LoadBestPreferences(2048x2048, 60)
792009-05-19 23:05:45.117 VDP: LoadBestPreferences(720x576, 60)
802009-05-19 23:05:45.118 VideoOutput: Preferred renderer: xv-blit
812009-05-19 23:05:45.118 VideoOutput: Trying video renderer: 'xv-blit'
822009-05-19 23:05:45.130 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
832009-05-19 23:05:45.130 VDP: LoadBestPreferences(2048x2048, 0)
842009-05-19 23:05:45.130 VDP: LoadBestPreferences(2048x2048, 60)
852009-05-19 23:05:45.139 VideoOutputXv: ctor
862009-05-19 23:05:45.140 VideoOutWindow::SetPIPState. pip_state: 0]
872009-05-19 23:05:45.170 VideoOutputXv: Creating XJ_gc
882009-05-19 23:05:45.170 VideoOutputXv: XJ_screen:     '0x9429ea8'
892009-05-19 23:05:45.170 VideoOutputXv: XJ_screen_num: '0'
902009-05-19 23:05:45.170 VideoOutputXv: XJ_curwin:     '52428805'
912009-05-19 23:05:45.171 VideoOutputXv: XJ_win:        '52428805'
922009-05-19 23:05:45.171 VideoOutputXv: XJ_root:       '122'
932009-05-19 23:05:45.171 VideoOutputXv: XJ_gc:         '0x8369e20'
942009-05-19 23:05:45.174 Display Rect  left: 0, top: 72, width: 1024, height: 432, aspect: 1.33333
952009-05-19 23:05:45.174 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
962009-05-19 23:05:45.174 VDP: LoadBestPreferences(720x576, 60)
972009-05-19 23:05:45.204 VideoOutputXv: Pixel dimensions: Screen 1920x1200, window 1024x576
982009-05-19 23:05:45.204 VideoOutputXv: Estimated display dimensions: 331x207 mm  Aspect: 1.59903
992009-05-19 23:05:45.204 VideoOutputXv: Estimated window dimensions: 176x99 mm  Aspect: 1.77778
1002009-05-19 23:05:45.234 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
1012009-05-19 23:05:45.238 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
1022009-05-19 23:05:45.238 VDP: LoadBestPreferences(2048x2048, 0)
1032009-05-19 23:05:45.238 VDP: LoadBestPreferences(2048x2048, 60)
1042009-05-19 23:05:45.238 VDP: LoadBestPreferences(720x576, 60)
1052009-05-19 23:05:45.243 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
1062009-05-19 23:05:45.243 VideoOutputXv: Adaptor#0: ATI Radeon Video Overlay has flag[s]: XvInputMask XvImageMask
1072009-05-19 23:05:45.243 VideoOutputXv: Has XVideo flags...
1082009-05-19 23:05:45.243 VideoOutputXv: Has XV_BRIGHTNESS...
1092009-05-19 23:05:45.243 VideoOutputXv: Here...
1102009-05-19 23:05:45.243 VideoOutputXv: Grabbed xv port 57
1112009-05-19 23:05:45.244 VideoOutputXv: XVideo surface found on port 57
1122009-05-19 23:05:45.244 VideoOutputXv: XVideo Adaptor Name: 'ATI Radeon Video Overlay'
1132009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #0 is 'RGBA'
1142009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #1 is 'RGBT'
1152009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #2 is 'RGB2'
1162009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #3 is '
1172009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #4 is 'YUY2'
1182009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #5 is 'UYVY'
1192009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #6 is 'YV12'
1202009-05-19 23:05:45.244 VideoOutputXv: XVideo Format #7 is 'I420'
1212009-05-19 23:05:45.244 VideoOutputXv: Using XVideo Format 'YV12'
1222009-05-19 23:05:45.244 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
1232009-05-19 23:05:45.402 VDP: SetVideoRenderer(xv-blit)
1242009-05-19 23:05:45.402 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
1252009-05-19 23:05:45.429 VideoOutputXv: PictureAttributes: Brightness, Contrast, Colour, Hue
1262009-05-19 23:05:45.439 Snapping height to avoid scaling: height: 576, top: 0
1272009-05-19 23:05:45.439 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.77778
1282009-05-19 23:05:45.440 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
1292009-05-19 23:05:45.442 Over/underscan. V: 0, H: 0
1302009-05-19 23:05:45.442 Snapping height to avoid scaling: height: 576, top: 0
1312009-05-19 23:05:45.443 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.77778
1322009-05-19 23:05:45.443 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
1332009-05-19 23:05:45.443 VDP: LoadBestPreferences(720x576, 25)
1342009-05-19 23:05:45.446 NVP(0): LoadFilters(''..) -> 0x0
1352009-05-19 23:05:45.448 OSD Theme Dimensions W: 640 H: 480
1362009-05-19 23:05:45.480 New DB connection, total: 3
1372009-05-19 23:05:45.485 Connected to database 'mythconverg' at host: sanfrancisco.koala.ie
1382009-05-19 23:05:47.368 playCtx: StartDecoderThread(): took 2274 ms to start player.
1392009-05-19 23:05:47.369 TV: StartPlayer(0, Watching WatchingLiveTV, main) -- end ok
1402009-05-19 23:05:47.369 TV: Changing from None to Watching WatchingLiveTV
1412009-05-19 23:05:47.369 TV: State is LiveTV & mctx == ctx
1422009-05-19 23:05:47.369 NVP(0): ClearAfterSeek(1)
1432009-05-19 23:05:47.370 VideoOutputXv: ClearAfterSeek()
1442009-05-19 23:05:47.370 VideoOutputXv: DiscardFrames(0)
1452009-05-19 23:05:47.370 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1462009-05-19 23:05:47.371 TV: UpdateOSDInput done
1472009-05-19 23:05:47.371 TV: UpdateLCD done
1482009-05-19 23:05:47.372 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
1492009-05-19 23:05:47.372 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
1502009-05-19 23:05:47.374 The realtime priority setting is not enabled.
1512009-05-19 23:05:47.374 TV: ITVRestart done
1522009-05-19 23:05:47.375 VDP: GetFilteredDeint() : xv-blit -> 'onefield'
1532009-05-19 23:05:47.377 FilterManager: GetFilterInfo(convert) returning: 0x0
1542009-05-19 23:05:47.387 FilterManager: GetFilterInfo(onefield) returning: 0x828a1c0
1552009-05-19 23:05:47.388 Using deinterlace method onefield
1562009-05-19 23:05:47.396 NVP(0): DoPause() -- begin
1572009-05-19 23:05:47.396 rate: 25 speed: 1 skip: 1 = interval 40000
1582009-05-19 23:05:47.396 NVP(0): DoPause() -- setting paused
1592009-05-19 23:05:47.437 Using video as timebase
1602009-05-19 23:05:47.437 Video timing method: DRM
1612009-05-19 23:05:47.437 Refresh rate: 16675, frame interval: 40000
1622009-05-19 23:05:47.479 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1632009-05-19 23:05:47.779 TV: HandleStateChange(0) -- end
1642009-05-19 23:05:47.818 ScreenSaverX11Private: ResetTimer -- begin
1652009-05-19 23:05:47.818 ScreenSaverX11Private: StopTimer
1662009-05-19 23:05:47.819 ScreenSaverX11Private: StartTimer
1672009-05-19 23:05:47.819 ScreenSaverX11Private: ResetTimer -- end
1682009-05-19 23:05:47.838 LiveTVChain(live-cozumel-windowed-2009-05-19T23:05:43): ReloadAll(): Added new recording
1692009-05-19 23:05:47.838 LiveTVChain(live-cozumel-windowed-2009-05-19T23:05:43): SwitchTo(1)
1702009-05-19 23:05:47.839 LiveTVChain(live-cozumel-windowed-2009-05-19T23:05:43): Entry@1: '7319_20090519230546'
1712009-05-19 23:05:47.839 JumpToProgram(void)
1722009-05-19 23:05:47.913 RingBuf(myth://195.7.61.35:6543/7319_20090519230543.mpg): OpenFile(myth://195.7.61.35:6543/7319_20090519230546.mpg, 12)
1732009-05-19 23:05:47.924 RemoteFile(myth://195.7.61.35:6543/7319_20090519230546.mpg)
1742009-05-19 23:05:47.925 RingBuf(myth://195.7.61.35:6543/7319_20090519230546.mpg): CalcReadAheadThresh(0 KB)
175                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
1762009-05-19 23:05:47.988 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1772009-05-19 23:05:48.195 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1782009-05-19 23:05:48.205 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1792009-05-19 23:05:48.413 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1802009-05-19 23:05:48.455 NVP(0): Waiting for prebuffer..  2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1812009-05-19 23:05:48.662 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1822009-05-19 23:05:48.671 NVP(0): Waiting for prebuffer..  3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1832009-05-19 23:05:48.878 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1842009-05-19 23:05:48.888 NVP(0): Waiting for prebuffer..  4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1852009-05-19 23:05:49.095 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1862009-05-19 23:05:49.104 NVP(0): Waiting for prebuffer..  5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1872009-05-19 23:05:49.311 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1882009-05-19 23:05:49.320 NVP(0): Waiting for prebuffer..  6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1892009-05-19 23:05:49.528 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1902009-05-19 23:05:49.537 NVP(0): Waiting for prebuffer..  7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1912009-05-19 23:05:49.744 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1922009-05-19 23:05:49.753 NVP(0): Waiting for prebuffer..  8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1932009-05-19 23:05:49.961 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1942009-05-19 23:05:49.970 NVP(0): Waiting for prebuffer..  9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1952009-05-19 23:05:50.131 NVP(0): Prebuffer wait timed out 10 times.
1962009-05-19 23:05:50.177 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1972009-05-19 23:05:50.186 NVP(0): Waiting for prebuffer.. 10 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1982009-05-19 23:05:50.393 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1992009-05-19 23:05:50.403 NVP(0): Waiting for prebuffer.. 11 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2002009-05-19 23:05:50.610 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2012009-05-19 23:05:50.619 NVP(0): Waiting for prebuffer.. 12 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2022009-05-19 23:05:50.826 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2032009-05-19 23:05:50.836 NVP(0): Waiting for prebuffer.. 13 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2042009-05-19 23:05:51.043 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2052009-05-19 23:05:51.052 NVP(0): Waiting for prebuffer.. 14 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2062009-05-19 23:05:51.259 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2072009-05-19 23:05:51.285 NVP(0): Waiting for prebuffer.. 15 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2082009-05-19 23:05:51.493 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2092009-05-19 23:05:51.502 NVP(0): Waiting for prebuffer.. 16 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2102009-05-19 23:05:51.536 AFD: Stream #0, has id 0x5200 codec id MPEG2VIDEO, type Video, bitrate 7980000 at 0x0x953dd80
2112009-05-19 23:05:51.556 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
2122009-05-19 23:05:51.556 VDP: LoadBestPreferences(2048x2048, 0)
2132009-05-19 23:05:51.556 VDP: LoadBestPreferences(2048x2048, 60)
2142009-05-19 23:05:51.557 VDP: LoadBestPreferences(720x576, 60)
2152009-05-19 23:05:51.559 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
2162009-05-19 23:05:51.560 VDP: LoadBestPreferences(2048x2048, 0)
2172009-05-19 23:05:51.560 VDP: LoadBestPreferences(2048x2048, 60)
2182009-05-19 23:05:51.560 VDP: LoadBestPreferences(720x576, 60)
2192009-05-19 23:05:51.560 Using 0 CPUs for decoding
2202009-05-19 23:05:51.560 AFD: InitVideoCodec() 0x942a070 id(MPEG2VIDEO) type (Video).
2212009-05-19 23:05:51.561 VideoOutputXv: InputChanged(720,576,1.33333) 'None'->'MPEG2'
2222009-05-19 23:05:51.562 VDP: GetFilteredDeint() : xv-blit -> 'onefield'
2232009-05-19 23:05:51.563 FilterManager: GetFilterInfo(convert) returning: 0x0
2242009-05-19 23:05:51.564 FilterManager: GetFilterInfo(onefield) returning: 0xa678a48
2252009-05-19 23:05:51.564 Using deinterlace method onefield
2262009-05-19 23:05:51.564 VideoOutputXv: DiscardFrames(1)
2272009-05-19 23:05:51.564 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2282009-05-19 23:05:51.564 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2292009-05-19 23:05:51.564 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2302009-05-19 23:05:51.565 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2312009-05-19 23:05:51.565 VideoOutputXv: DiscardFrames(1)
2322009-05-19 23:05:51.565 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2332009-05-19 23:05:51.565 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2342009-05-19 23:05:51.565 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2352009-05-19 23:05:51.565 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2362009-05-19 23:05:51.566 VideoOutputXv: DiscardFrames(1)
2372009-05-19 23:05:51.566 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2382009-05-19 23:05:51.566 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2392009-05-19 23:05:51.566 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2402009-05-19 23:05:51.566 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2412009-05-19 23:05:51.568 VideoOutputXv: Closing XVideo port 57
2422009-05-19 23:05:51.571 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2432009-05-19 23:05:51.575 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) rend(xv-blit) osd(softblend) osdfade(disabled) deint(onefield,none) filt()
2442009-05-19 23:05:51.575 VDP: LoadBestPreferences(2048x2048, 0)
2452009-05-19 23:05:51.575 VDP: LoadBestPreferences(2048x2048, 60)
2462009-05-19 23:05:51.575 VDP: LoadBestPreferences(720x576, 60)
2472009-05-19 23:05:51.579 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
2482009-05-19 23:05:51.579 VideoOutputXv: Adaptor#0: ATI Radeon Video Overlay has flag[s]: XvInputMask XvImageMask
2492009-05-19 23:05:51.579 VideoOutputXv: Has XVideo flags...
2502009-05-19 23:05:51.579 VideoOutputXv: Has XV_BRIGHTNESS...
2512009-05-19 23:05:51.579 VideoOutputXv: Here...
2522009-05-19 23:05:51.580 VideoOutputXv: Grabbed xv port 57
2532009-05-19 23:05:51.580 VideoOutputXv: XVideo surface found on port 57
2542009-05-19 23:05:51.580 VideoOutputXv: XVideo Adaptor Name: 'ATI Radeon Video Overlay'
2552009-05-19 23:05:51.580 VideoOutputXv: XVideo Format #0 is 'RGBA'
2562009-05-19 23:05:51.580 VideoOutputXv: XVideo Format #1 is 'RGBT'
2572009-05-19 23:05:51.580 VideoOutputXv: XVideo Format #2 is 'RGB2'
2582009-05-19 23:05:51.581 VideoOutputXv: XVideo Format #3 is '
2592009-05-19 23:05:51.581 VideoOutputXv: XVideo Format #4 is 'YUY2'
2602009-05-19 23:05:51.581 VideoOutputXv: XVideo Format #5 is 'UYVY'
2612009-05-19 23:05:51.581 VideoOutputXv: XVideo Format #6 is 'YV12'
2622009-05-19 23:05:51.581 VideoOutputXv: XVideo Format #7 is 'I420'
2632009-05-19 23:05:51.581 VideoOutputXv: Using XVideo Format 'YV12'
2642009-05-19 23:05:51.581 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2652009-05-19 23:05:51.697 VDP: SetVideoRenderer(xv-blit)
2662009-05-19 23:05:51.697 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2672009-05-19 23:05:51.698 VideoOutputXv: PictureAttributes: Brightness, Contrast, Colour, Hue
2682009-05-19 23:05:51.721 Snapping height to avoid scaling: height: 576, top: 0
2692009-05-19 23:05:51.721 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.77778
2702009-05-19 23:05:51.721 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
2712009-05-19 23:05:51.722 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2722009-05-19 23:05:52.449 NVP(0): ClearAfterSeek(1)
2732009-05-19 23:05:52.450 VideoOutputXv: ClearAfterSeek()
2742009-05-19 23:05:52.450 VideoOutputXv: DiscardFrames(0)
2752009-05-19 23:05:52.450 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2762009-05-19 23:05:52.450 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2772009-05-19 23:05:52.450 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2782009-05-19 23:05:52.455 NVP(0): LoadFilters(''..) -> 0x0
2792009-05-19 23:05:52.455 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2802009-05-19 23:05:52.456 AFD: Using ffmpeg for video decoding
2812009-05-19 23:05:52.456 AFD: Looking for decoder for MPEG2VIDEO
2822009-05-19 23:05:52.456 AFD: Opened codec 0x942a070, id(MPEG2VIDEO) type(Video)
2832009-05-19 23:05:52.456 AFD: Stream #1, has id 0x5201 codec id MP3, type Audio, bitrate 256000 at 0x0x95aba90
2842009-05-19 23:05:52.457 AFD: codec MP3 has 2 channels
2852009-05-19 23:05:52.457 AFD: Looking for decoder for MP3
2862009-05-19 23:05:52.457 AFD: Opened codec 0x83cf9a0, id(MP3) type(Audio)
2872009-05-19 23:05:52.457 AFD: Stream #2, has id 0x5202 codec id MP3, type Audio, bitrate 256000 at 0x0x9542f30
2882009-05-19 23:05:52.466 AFD: codec MP3 has 2 channels
2892009-05-19 23:05:52.466 AFD: Looking for decoder for MP3
2902009-05-19 23:05:52.466 AFD: Opened codec 0x9570470, id(MP3) type(Audio)
2912009-05-19 23:05:52.466 AFD: Stream #3, has id 0x5203 codec id DVB_VBI, type Data, bitrate 0 at 0x0x9619d10
2922009-05-19 23:05:52.466 AFD: Teletext caption #1 is in the English language on page 8 136.
2932009-05-19 23:05:52.467 AFD: data codec (Data)
2942009-05-19 23:05:52.467 AFD: Stream #4, has id 0x3846 codec id DSMCC_B, type Data, bitrate 0 at 0x0x9543e70
2952009-05-19 23:05:52.467 AFD: data codec (Data)
2962009-05-19 23:05:52.467 AFD: Stream #5, has id 0x3847 codec id DSMCC_B, type Data, bitrate 0 at 0x0x95b1be0
2972009-05-19 23:05:52.467 AFD: data codec (Data)
2982009-05-19 23:05:52.467 NVP(0): Waiting for prebuffer.. 17 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2992009-05-19 23:05:52.467 AFD: Stream #6, has id 0x3848 codec id DSMCC_B, type Data, bitrate 0 at 0x0x95461f0
3002009-05-19 23:05:52.468 AFD: data codec (Data)
3012009-05-19 23:05:52.468 AFD: Stream #7, has id 0x3849 codec id DSMCC_B, type Data, bitrate 0 at 0x0x8346ca0
3022009-05-19 23:05:52.468 AFD: data codec (Data)
3032009-05-19 23:05:52.469 AFD: Stream #8, has id 0x5204 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x95b39f0
3042009-05-19 23:05:52.469 AFD: subtitle codec (Subtitle)
3052009-05-19 23:05:52.469 AFD: Looking for decoder for DVB_SUBTITLE
3062009-05-19 23:05:52.469 AFD: Opened codec 0x8266a90, id(DVB_SUBTITLE) type(Subtitle)
3072009-05-19 23:05:52.479 AFD: Subtitle track #1 is A/V stream #8 and is in the English language(6647399).
3082009-05-19 23:05:52.542 RingBuf(myth://195.7.61.35:6543/7319_20090519230546.mpg): CalcReadAheadThresh(0 KB)
309                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
3102009-05-19 23:05:52.553 Opening audio device 'default'. ch 2(2) sr 48000
3112009-05-19 23:05:52.553 Opening ALSA audio device 'default'.
3122009-05-19 23:05:52.584 NVP(0): Enabling Audio
3132009-05-19 23:05:52.584 Dec: Selected track #1 in the English language(6647399)
3142009-05-19 23:05:52.584 Dec: Trying to select track (w/lang)
3152009-05-19 23:05:52.584 Dec: Selecting first track
3162009-05-19 23:05:52.584 Dec: Selected track #1 in the Unknown language(0)
3172009-05-19 23:05:52.584 Dec: Selected track #1 in the English language(6647399)
3182009-05-19 23:05:52.585 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
3192009-05-19 23:05:52.587 Position map filled from DB to: 62
3202009-05-19 23:05:52.587 Dec: SyncPositionMap watchingrecording, from DB: 6 entries
3212009-05-19 23:05:52.587 NVP(0): Filling position map from 63 to end
3222009-05-19 23:05:52.590 Dec: Position map filled from Encoder to: 110
3232009-05-19 23:05:52.590 Dec: SyncPositionMap watchingrecording total: 10 entries
3242009-05-19 23:05:52.590 Dec: SyncPositionMap, new totframes: 110, new length: 4, posMap size: 10
3252009-05-19 23:05:52.590 AFD: Partial position map found
3262009-05-19 23:05:52.590 AFD: Successfully opened decoder for file: "myth://195.7.61.35:6543/7319_20090519230546.mpg". novideo(0)
3272009-05-19 23:05:52.604 NVP(0): DoPlay() -- begin
3282009-05-19 23:05:52.604 NVP(0): DoPlay: rate: 25 speed: 1 skip: 1 => new interval 40000
3292009-05-19 23:05:52.604 Set video sync frame interval to 40000
3302009-05-19 23:05:52.604 NVP(0): Stretch Factor 1, allow passthru
3312009-05-19 23:05:52.604 NVP(0): DoPlay() -- setting unpaused
3322009-05-19 23:05:52.620 RingBuf(myth://195.7.61.35:6543/7319_20090519230546.mpg): CalcReadAheadThresh(0 KB)
333                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
3342009-05-19 23:05:52.621 Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
3352009-05-19 23:05:52.622 Position map filled from DB to: 62
3362009-05-19 23:05:52.622 Dec: SyncPositionMap watchingrecording, from DB: 6 entries
3372009-05-19 23:05:52.622 NVP(0): Filling position map from 63 to end
3382009-05-19 23:05:52.625 Dec: Position map filled from Encoder to: 110
3392009-05-19 23:05:52.625 Dec: SyncPositionMap watchingrecording total: 10 entries
3402009-05-19 23:05:52.656 NVP(0): Waiting for prebuffer.. 18 LLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3412009-05-19 23:05:52.835 NVP(0): Waiting for prebuffer.. 19 UUUUUUUuUULLAAAAAAAAAAAAAAAAAAA
342'video_output' mean = '39810.25', std. dev. = '9595.22', fps = '25.12'
343SetSubtitleMode ResidentProgram is not implemented
344'video_output' mean = '39960.47', std. dev. = '19910.33', fps = '25.02'
345'video_output' mean = '39948.53', std. dev. = '26834.37', fps = '25.03'
3462009-05-19 23:06:06.970 NVP(0): Video is 3.60297 frames behind audio (too slow), dropping frame to catch up.
3472009-05-19 23:06:06.973 NVP(0): Video is 3.88348 frames behind audio (too slow), dropping frame to catch up.
3482009-05-19 23:06:06.983 NVP(0): Video is 3.90635 frames behind audio (too slow), dropping frame to catch up.
3492009-05-19 23:06:06.989 NVP(0): Video is 3.711 frames behind audio (too slow), dropping frame to catch up.
3502009-05-19 23:06:06.995 NVP(0): Video is 3.352 frames behind audio (too slow), dropping frame to catch up.
3512009-05-19 23:06:08.738 NVP(0): 400 interlaced frames seen.
352'video_output' mean = '40121.50', std. dev. = '31975.64', fps = '24.92'
353'video_output' mean = '39954.87', std. dev. = '9085.62', fps = '25.03'
354'video_output' mean = '39966.02', std. dev. = '9159.97', fps = '25.02'
355'video_output' mean = '39941.56', std. dev. = '9309.54', fps = '25.04'
3562009-05-19 23:06:24.721 NVP(0): 800 interlaced frames seen.
357'video_output' mean = '39950.93', std. dev. = '8717.20', fps = '25.03'
358'video_output' mean = '39959.60', std. dev. = '8511.33', fps = '25.03'
359'video_output' mean = '39952.44', std. dev. = '8472.57', fps = '25.03'
3602009-05-19 23:06:34.879 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
3612009-05-19 23:06:34.879 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
3622009-05-19 23:06:34.920 TV: HandleStateChange(0) -- begin
3632009-05-19 23:06:34.921 TV: Attempting to change from Watching WatchingLiveTV to None
3642009-05-19 23:06:34.921 TV: StopStuff() for player ctx 0 -- begin
3652009-05-19 23:06:34.921 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
3662009-05-19 23:06:34.921 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
3672009-05-19 23:06:34.921 TV: StopStuff(): stopping ring buffer
3682009-05-19 23:06:34.931 NVP(0): Exited decoder loop.
3692009-05-19 23:06:34.946 TV: StopStuff(): stopping player
3702009-05-19 23:06:34.947 TV: StopStuff(): stopping recorder
3712009-05-19 23:06:34.981 VideoOutputXv: dtor
3722009-05-19 23:06:34.982 VideoOutputXv: DiscardFrames(1)
3732009-05-19 23:06:34.982 VideoBuffers::DiscardFrames(1): UUuAUUUUUUUUUUUUUUUUUUuUULUUUUU
3742009-05-19 23:06:34.982 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3752009-05-19 23:06:34.983 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3762009-05-19 23:06:34.983 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3772009-05-19 23:06:34.983 VideoOutputXv: DiscardFrames(1)
3782009-05-19 23:06:34.983 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3792009-05-19 23:06:34.983 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3802009-05-19 23:06:34.983 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3812009-05-19 23:06:34.984 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3822009-05-19 23:06:34.985 VideoOutputXv: Closing XVideo port 57
3832009-05-19 23:06:35.304 TV: StopStuff() -- end
3842009-05-19 23:06:35.304 TV: Changing from Watching WatchingLiveTV to None
3852009-05-19 23:06:35.304 TV: HandleStateChange(0) -- end
3862009-05-19 23:06:35.305 TV: StartTV -- process events end
3872009-05-19 23:06:35.305 TV: StartTV -- process events 2 begin
3882009-05-19 23:06:35.305 ScreenSaverX11Private: StopTimer
3892009-05-19 23:06:35.305 TV: StartTV -- process events 2 end
3902009-05-19 23:06:35.306 TV::~TV() -- begin
3912009-05-19 23:06:35.307 TV::~TV() -- lock
3922009-05-19 23:06:35.366 TV::~TV() -- end
3932009-05-19 23:06:35.367 TV: StartTV -- end
3942009-05-19 23:06:37.645 Deleting UPnP client...