2009-04-01 10:40:03.742 Using runtime prefix = /usr 2009-04-01 10:40:03.743 Empty LocalHostName. 2009-04-01 10:40:03.743 Using localhost value of apollo.wilsonet.com 2009-04-01 10:40:03.749 New DB connection, total: 1 2009-04-01 10:40:03.754 Connected to database 'mythconverg' at host: chronos.wilsonet.com 2009-04-01 10:40:03.754 Closing DB connection named 'DBManager0' 2009-04-01 10:40:03.763 ScreenSaverX11Private: Gnome screen saver support enabled 2009-04-01 10:40:03.764 DPMS is active. 2009-04-01 10:40:03.766 Primary screen: 0. 2009-04-01 10:40:03.768 Connected to database 'mythconverg' at host: chronos.wilsonet.com 2009-04-01 10:40:03.771 Using screen 0, 1920x1080 at 0,0 2009-04-01 10:40:03.800 MythUI Image Cache size set to 20971520 bytes 2009-04-01 10:40:03.806 Current Schema Version: 1232 2009-04-01 10:40:04.593 max_width: 1920 max_height: 1080 2009-04-01 10:40:04.596 Primary screen: 0. 2009-04-01 10:40:04.597 Using screen 0, 1920x1080 at 0,0 2009-04-01 10:40:04.599 Using theme base resolution of 1280x720 2009-04-01 10:40:04.622 LIRC: Successfully initialized '/dev/lircd' using '/home/jarod/.mythtv/lircrc' config 2009-04-01 10:40:04.622 JoystickMenuThread Error: Joystick disabled - Failed to read /home/jarod/.mythtv/joystickmenurc 2009-04-01 10:40:04.855 Using the Qt painter 2009-04-01 10:40:05.168 TV: ctor 2009-04-01 10:40:05.243 New DB connection, total: 2 2009-04-01 10:40:05.246 Connected to database 'mythconverg' at host: chronos.wilsonet.com 2009-04-01 10:40:05.375 New DB connection, total: 3 2009-04-01 10:40:05.378 Connected to database 'mythconverg' at host: chronos.wilsonet.com 2009-04-01 10:40:05.382 TV: StartTV() -- begin 2009-04-01 10:40:05.382 TV: ctor 2009-04-01 10:40:05.469 TV: tv->Playback() -- begin 2009-04-01 10:40:05.503 Connecting to backend server: 172.31.27.17:6543 (try 1 of 5) 2009-04-01 10:40:05.504 Using protocol version 44 2009-04-01 10:40:05.565 TV: tv->Playback() -- end 2009-04-01 10:40:05.565 TV: StartTV -- process events begin 2009-04-01 10:40:05.586 TV: HandleStateChange(0) -- begin 2009-04-01 10:40:05.586 TV: Attempting to change from None to Watching WatchingPreRecorded 2009-04-01 10:40:05.590 RingBuf(/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg): OpenFile(/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg, 12) 2009-04-01 10:40:05.607 RingBuf(/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg): CalcReadAheadThresh(0 KB) -> threshhold(64 KB) min read(0 KB) blk size(32 KB) 2009-04-01 10:40:05.608 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- begin 2009-04-01 10:40:06.293 mpegts_add_stream: at pid 0x7c0 with type 2 2009-04-01 10:40:06.348 mpegts_add_stream: stream #0, has id 0x7c0 and codec MPEG2VIDEO, type Video at 0xac5d10 2009-04-01 10:40:06.349 mpegts_add_stream: at pid 0x7c1 with type 129 2009-04-01 10:40:06.350 mpegts_add_stream: stream #1, has id 0x7c1 and codec AC3, type Audio at 0xac6450 2009-04-01 10:40:06.350 mpegts_add_stream: at pid 0x7c2 with type 129 2009-04-01 10:40:06.351 mpegts_add_stream: stream #2, has id 0x7c2 and codec AC3, type Audio at 0xb25d40 2009-04-01 10:40:06.768 AFD: Stream #0, has id 0x1984 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x0xac5d10 2009-04-01 10:40:06.789 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,linearblend) filt() 2009-04-01 10:40:06.789 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt() 2009-04-01 10:40:06.789 VDP: LoadBestPreferences(2048x2048, 0) 2009-04-01 10:40:06.790 VDP: LoadBestPreferences(2048x2048, 60) 2009-04-01 10:40:06.790 VDP: LoadBestPreferences(704x480, 60) 2009-04-01 10:40:06.794 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,linearblend) filt() 2009-04-01 10:40:06.795 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt() 2009-04-01 10:40:06.795 VDP: LoadBestPreferences(2048x2048, 0) 2009-04-01 10:40:06.795 VDP: LoadBestPreferences(2048x2048, 60) 2009-04-01 10:40:06.796 VDP: LoadBestPreferences(704x480, 60) 2009-04-01 10:40:06.796 Using 2 CPUs for decoding 2009-04-01 10:40:06.796 AFD: InitVideoCodec() 0xac5ec0 id(MPEG2VIDEO) type (Video). 2009-04-01 10:40:06.797 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-04-01 10:40:06.797 AFD: EIA-708 caption service #1 is in the English language. 2009-04-01 10:40:06.797 AFD: Using ffmpeg for video decoding 2009-04-01 10:40:06.798 AFD: Looking for decoder for MPEG2VIDEO 2009-04-01 10:40:06.798 AFD: Opened codec 0xac5ec0, id(MPEG2VIDEO) type(Video) 2009-04-01 10:40:06.798 AFD: Stream #1, has id 0x1985 codec id AC3, type Audio, bitrate 192000 at 0x0xac6450 2009-04-01 10:40:06.798 AFD: codec AC3 has 2 channels 2009-04-01 10:40:06.799 AFD: Looking for decoder for AC3 No accelerated IMDCT transform found 2009-04-01 10:40:06.800 AFD: Opened codec 0xac6600, id(AC3) type(Audio) 2009-04-01 10:40:06.801 AFD: Stream #2, has id 0x1986 codec id AC3, type Audio, bitrate 128000 at 0x0xb25d40 2009-04-01 10:40:06.801 AFD: codec AC3 has 1 channels 2009-04-01 10:40:06.801 AFD: Looking for decoder for AC3 No accelerated IMDCT transform found 2009-04-01 10:40:06.803 AFD: Opened codec 0xb25ef0, id(AC3) type(Audio) 2009-04-01 10:40:06.803 RingBuf(/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg): CalcReadAheadThresh(0 KB) -> threshhold(64 KB) min read(0 KB) blk size(32 KB) 2009-04-01 10:40:06.808 Opening audio device 'digital'. ch 6(2) sr 48000 2009-04-01 10:40:06.808 Opening ALSA audio device 'digital'. 2009-04-01 10:40:06.966 Opening audio device 'digital'. ch 2(2) sr 48000 2009-04-01 10:40:06.967 Opening ALSA audio device 'digital'. 2009-04-01 10:40:06.972 Dec: Trying to select track (w/lang) 2009-04-01 10:40:06.973 Dec: Selecting first track 2009-04-01 10:40:06.973 Dec: Selected track #1 in the Unknown language(0) 2009-04-01 10:40:06.973 Dec: Selected track #1 in the English language(6647399) 2009-04-01 10:40:06.973 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-04-01 10:40:07.254 Position map filled from DB to: 61020 2009-04-01 10:40:07.254 Dec: SyncPositionMap prerecorded, from DB: 4069 entries 2009-04-01 10:40:07.255 Dec: SyncPositionMap, new totframes: 61020, new length: 2036, posMap size: 4069 2009-04-01 10:40:07.255 Input #0, mpegts, from '/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg': 2009-04-01 10:40:07.255 Duration: 00:33:56.77, start: 30250.402567, bitrate: 4443 kb/s 2009-04-01 10:40:07.256 Stream #0.0[0x7c0], 1/90000: Video: mpeg2video, yuv420p, 704x480 [PAR 10:11 DAR 4:3], 1001/30000, 15000 kb/s, 29.97 tb(r) 2009-04-01 10:40:07.256 Stream #0.1[0x7c1](eng), 1/90000: Audio: liba52, 48000 Hz, stereo, s16, 192 kb/s 2009-04-01 10:40:07.256 Stream #0.2[0x7c2](eng), 1/90000: Audio: liba52, 48000 Hz, mono, s16, 128 kb/s 2009-04-01 10:40:07.257 AFD: Position map found 2009-04-01 10:40:07.257 AFD: Successfully opened decoder for file: "/storage/television/Word_World_-_Castles_in_the_Sea;_Get_Your_Coat.mpg". novideo(0) 2009-04-01 10:40:07.286 VideoOutput: Allowed renderers: ivtv,xv-blit,xshm,xlib,opengl 2009-04-01 10:40:07.287 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,xv-blit,opengl 2009-04-01 10:40:07.291 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,linearblend) filt() 2009-04-01 10:40:07.292 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt() 2009-04-01 10:40:07.292 VDP: LoadBestPreferences(2048x2048, 0) 2009-04-01 10:40:07.292 VDP: LoadBestPreferences(2048x2048, 60) 2009-04-01 10:40:07.293 VDP: LoadBestPreferences(704x480, 60) 2009-04-01 10:40:07.293 VideoOutput: Preferred renderer: xv-blit 2009-04-01 10:40:07.293 VideoOutput: Trying video renderer: 'xv-blit' 2009-04-01 10:40:07.317 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,linearblend) filt() 2009-04-01 10:40:07.317 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt() 2009-04-01 10:40:07.318 VDP: LoadBestPreferences(2048x2048, 0) 2009-04-01 10:40:07.318 VDP: LoadBestPreferences(2048x2048, 60) 2009-04-01 10:40:07.326 VideoOutputXv: ctor 2009-04-01 10:40:07.326 VideoOutWindow::SetPIPState. pip_state: 0] 2009-04-01 10:40:07.327 VideoOutputXv: Creating XJ_gc 2009-04-01 10:40:07.328 VideoOutputXv: XJ_screen: '0x1393340' 2009-04-01 10:40:07.328 VideoOutputXv: XJ_screen_num: '0' 2009-04-01 10:40:07.328 VideoOutputXv: XJ_curwin: '62914592' 2009-04-01 10:40:07.329 VideoOutputXv: XJ_win: '62914592' 2009-04-01 10:40:07.329 VideoOutputXv: XJ_root: '265' 2009-04-01 10:40:07.329 VideoOutputXv: XJ_gc: '0x11dbdf0' 2009-04-01 10:40:07.343 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.33333 2009-04-01 10:40:07.343 Video Rect left: 0, top: 0, width: 704, height: 480, aspect: 1.33333 2009-04-01 10:40:07.344 VDP: LoadBestPreferences(704x480, 60) 2009-04-01 10:40:07.364 VideoOutputXv: Pixel dimensions: Screen 1920x1080, window 1920x1080 2009-04-01 10:40:07.364 VideoOutputXv: Estimated display dimensions: 820x461 mm Aspect: 1.77874 2009-04-01 10:40:07.365 VideoOutputXv: Estimated window dimensions: 820x461 mm Aspect: 1.77874 2009-04-01 10:40:07.366 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib 2009-04-01 10:40:07.370 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,linearblend) filt() 2009-04-01 10:40:07.370 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt() 2009-04-01 10:40:07.371 VDP: LoadBestPreferences(2048x2048, 0) 2009-04-01 10:40:07.371 VDP: LoadBestPreferences(2048x2048, 60) 2009-04-01 10:40:07.371 VDP: LoadBestPreferences(704x480, 60) 2009-04-01 10:40:07.372 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask 10 2009-04-01 10:40:07.372 VideoOutputXv: Adaptor#0: Intel(R) Textured Video has flag[s]: XvInputMask XvImageMask 2009-04-01 10:40:07.372 VideoOutputXv: Has XVideo flags... 2009-04-01 10:40:07.373 VideoOutputXv: Has XV_BRIGHTNESS... 2009-04-01 10:40:07.373 VideoOutputXv: Here... 2009-04-01 10:40:07.374 VideoOutputXv: Grabbed xv port 79 2009-04-01 10:40:07.374 VideoOutputXv: XVideo surface found on port 79 2009-04-01 10:40:07.374 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Textured Video' 2009-04-01 10:40:07.375 VideoOutputXv: XVideo Format #0 is 'YUY2' 2009-04-01 10:40:07.375 VideoOutputXv: XVideo Format #1 is 'YV12' 2009-04-01 10:40:07.375 VideoOutputXv: XVideo Format #2 is 'I420' 2009-04-01 10:40:07.376 VideoOutputXv: XVideo Format #3 is 'UYVY' 2009-04-01 10:40:07.376 VideoOutputXv: XVideo Format #4 is 'XVMC' 2009-04-01 10:40:07.376 VideoOutputXv: Using XVideo Format 'YV12' 2009-04-01 10:40:07.377 VideoOutputXv: CreateShmImages(32): video_dim: 704x480 2009-04-01 10:40:07.413 VDP: SetVideoRenderer(xv-blit) 2009-04-01 10:40:07.414 VDP: SetVideoRender(xv-blit) == GetVideoRenderer() 2009-04-01 10:40:07.414 VideoOutputXv: Chromakeying not possible with this XVideo port. 2009-04-01 10:40:07.414 Display Rect left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778 2009-04-01 10:40:07.414 Video Rect left: 0, top: 0, width: 704, height: 480, aspect: 1.33333 2009-04-01 10:40:07.419 Over/underscan. V: 0, H: 0 2009-04-01 10:40:07.419 Display Rect left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778 2009-04-01 10:40:07.419 Video Rect left: 0, top: 0, width: 704, height: 480, aspect: 1.33333 2009-04-01 10:40:07.420 VDP: LoadBestPreferences(704x480, 29.97) 2009-04-01 10:40:07.421 NVP(0): LoadFilters(''..) -> 0x0 2009-04-01 10:40:07.423 OSD Theme Dimensions W: 1280 H: 720 2009-04-01 10:40:08.270 NVP(0): ClearAfterSeek(1) 2009-04-01 10:40:08.270 VideoOutputXv: ClearAfterSeek() 2009-04-01 10:40:08.270 VideoOutputXv: DiscardFrames(0) 2009-04-01 10:40:08.270 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-04-01 10:40:08.270 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-04-01 10:40:08.270 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-04-01 10:40:08.270 playCtx: StartDecoderThread(): took 983 ms to start player. 2009-04-01 10:40:08.271 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- end ok 2009-04-01 10:40:08.271 Using realtime priority. 2009-04-01 10:40:08.271 TV: Changing from None to Watching WatchingPreRecorded 2009-04-01 10:40:08.273 VDP: GetFilteredDeint() : xv-blit -> 'bobdeint' 2009-04-01 10:40:08.274 TV: HandleStateChange(0) -- end 2009-04-01 10:40:08.275 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-04-01 10:40:08.275 FilterManager: GetFilterInfo(bobdeint) returning: 0x7f3e80054540 2009-04-01 10:40:08.276 Using deinterlace method bobdeint 2009-04-01 10:40:08.291 Set video sync frame interval to 33366 2009-04-01 10:40:08.296 ScreenSaverX11Private: DPMS Deactivated 1 2009-04-01 10:40:08.296 ScreenSaverX11Private: ResetTimer -- begin 2009-04-01 10:40:08.296 ScreenSaverX11Private: StopTimer 2009-04-01 10:40:08.297 ScreenSaverX11Private: StartTimer 2009-04-01 10:40:08.297 ScreenSaverX11Private: ResetTimer -- end 2009-04-01 10:40:08.308 Using audio as timebase 2009-04-01 10:40:08.308 Video timing method: DRM 2009-04-01 10:40:08.308 Refresh rate: 16685, frame interval: 33366 2009-04-01 10:40:08.310 AFD: DoFastForward(3747 (1), do discard frames) 2009-04-01 10:40:08.310 Dec: DoFastForward(3747 (1), do discard frames) 2009-04-01 10:40:08.310 Dec: FindPosition(3747, search not adjusted) --> [249(69229684),250(69502096)] 2009-04-01 10:40:08.310 AFD: SeekReset(3750, 0, do flush, do discard) 2009-04-01 10:40:08.310 AFD: SeekReset() flushing 2009-04-01 10:40:08.310 VideoOutputXv: DiscardFrames(1) 2009-04-01 10:40:08.310 VideoBuffers::DiscardFrames(1): UAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-04-01 10:40:08.310 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-04-01 10:40:08.311 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-04-01 10:40:08.311 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-04-01 10:40:08.311 NVP(0): ClearAfterSeek(0) 2009-04-01 10:40:08.325 NVP(0): Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-04-01 10:40:08.459 NVP(0): Waiting for prebuffer.. 1 AAUuUULuAAAAAAAAAAAAAAAAAAAAAAA 2009-04-01 10:40:10.551 NVP(0): Timed out waiting for free video buffers. 2009-04-01 10:40:12.580 NVP(0): Timed out waiting for free video buffers. 2009-04-01 10:40:14.607 NVP(0): Timed out waiting for free video buffers. ^CSignal: Interrupt Ungrabbing XVideo port: 79