[mythtv-users] Can't see ogv videos

Mike's JdJ stepsisters at comcast.net
Mon Jun 1 01:37:22 UTC 2015


On 05/31/2015 02:48 PM, Mark Perkins wrote:
>
>
>> On 31 May 2015, at 11:54 pm, "Mike's JdJ" <stepsisters at comcast.net> wrote:
>>
>>
>> Really?  No one else is getting a black screen playing ogv in the MythTV FrontEnd?  No one here has any idea what might be wrong?
>>
>>> On 05/26/2015 07:34 PM, Mike's JdJ wrote:
>>>
>>> Something changed and I don't know where to look.
>>>
>>> In MythTV FrontEnd, when I play a .ogv video, I get the
>>> soundtrack, but a black screen.
>>>
>>> The files used to play fine, but now have no video.
>>>
>>> The videos are stored in var/lib/mythtv/videos
>>>
>>> The files play fine with VLC and Videos.
>>>
>>> mp4 and mkv files in the same folder play fine in the MythTV
>>> FrontEnds.
>>>
>>> I used to watch the same files fine on Ubuntu 11.04 and MythTV
>>> 0.24.  Now I am on Ubuntu 12.04 and MythTV v0.27.4-64-g8fd277b.
>>>
>>> The ogv black screen FrontEnd problem is on the MythTV BackEnd
>>> desktop AND the remote FrontEnds.
>>>
>>> A typical ogv stream is Xiph.org's Theora Video, resolution
>>> 400x304, display resolution 400x300, frame rate 29.97, mythtv
>>> permission Read-only
>>>
>>> In Ubuntu Software, I have the main, universe, restricted, and
>>> multiverse checked.  No proprietary drivers.
>>> _______________________________________________
>>
>> Really?  No one else is getting a black screen playing ogv in the MythTV FrontEnd?  No one here has any idea what might be wrong?
>> _______________________________________________
>>
>
> I don't have any ogv files to test. What do the logs say?
>

Thanks for the response Mark.

I got the .ogv files from archive.org.  They have some 
commercials and TV shows from the 1950s.  Interesting stuff.


Logs

I waited for the system to quiet down, then requested the .ogv 
video.

cat /var/log/mythtv/mythbackend.log   -   nothing found for the 
time period

cat /var/log/syslog   -   nothing found for the time period

cat /var/log/mysqld/mysqld.log
cat: /var/log/mysqld/mysqld.log: No such file or directory

mythfrontend -v all
2015-05-31 20:10:00.009919 I  (0x567ff18)::IncrRef() -> 2
2015-05-31 20:10:00.009977 I  (0x567ff18)::DecrRef() -> 1
2015-05-31 20:10:03.637706 N  Suspending idle timer
2015-05-31 20:10:03.637793 I  RemoteFile::Exists(): looking for 
remote file: myth://Videos@colossus/Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv/VIDEO_TS
2015-05-31 20:10:03.637902 I  MythSocket(7f330c00c960:63): write 
-> 63 89      QUERY_FILE_EXISTS[]:[]Colgate Comedy - 
Abbott_Costello 7 Jan 1951...
2015-05-31 20:10:03.640505 I  MythSocket(7f330c00c960:63): read 
  <- 63 1       0
2015-05-31 20:10:03.640604 I  RemoteFile::Exists(): looking for 
remote file: myth://Videos@colossus/Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv/BDMV
2015-05-31 20:10:03.640665 I  MythSocket(7f330c00c960:63): write 
-> 63 85      QUERY_FILE_EXISTS[]:[]Colgate Comedy - 
Abbott_Costello 7 Jan 1951...
2015-05-31 20:10:03.641973 I  MythSocket(7f330c00c960:63): read 
  <- 63 1       0
2015-05-31 20:10:03.642387 I  TV: Creating TV object
Failed to open VDPAU backend libvdpau_i965.so: cannot open 
shared object file: No such file or directory
2015-05-31 20:10:03.653395 I  TV: Finished creating TV object
2015-05-31 20:10:03.653402 I  TV: StartTV() -- begin
2015-05-31 20:10:03.653420 N  Suspending idle timer
2015-05-31 20:10:03.653425 I  TV: Init -- begin
2015-05-31 20:10:03.654222 I  MythSocket(7f330c00c960:63): write 
-> 63 69      MESSAGE[]:[]SYSTEM_EVENT SCREEN_TYPE CREATED 
Playback SENDER colo...
2015-05-31 20:10:03.654360 I  MythUIHelper: 
LoadCacheImage(Images/progressbar_bg.png,Images-progressbar_bg.png---1x-1.png)
2015-05-31 20:10:03.654381 I  (0x7f331800ffd8)::IncrRef() -> 5
2015-05-31 20:10:03.654447 I  (0x7f331800ffd8)::DecrRef() -> 4
2015-05-31 20:10:03.654470 I  MythUIHelper: 
LoadCacheImage(Images/progressbar_bg.png,Images-progressbar_bg.png---1x-1.png)
2015-05-31 20:10:03.654483 I  (0x7f331800ffd8)::IncrRef() -> 5
2015-05-31 20:10:03.654490 I  (0x7f331800ffd8)::IncrRef() -> 6
2015-05-31 20:10:03.654495 I  (0x7f331800ffd8)::DecrRef() -> 5
2015-05-31 20:10:03.654502 I 
ImageLoader::LoadImage(Images-progressbar_bg.png---1x-1.png) 
Found in cache, RefCount = 5
2015-05-31 20:10:03.654552 I  MythUIHelper: 
LoadCacheImage(Images/progressbar_fill.png,Images-progressbar_fill.png---1x-1.png)
2015-05-31 20:10:03.654562 I  (0x7f332801d728)::IncrRef() -> 5
2015-05-31 20:10:03.654590 I  (0x7f332801d728)::DecrRef() -> 4
2015-05-31 20:10:03.654602 I  MythUIHelper: 
LoadCacheImage(Images/progressbar_fill.png,Images-progressbar_fill.png---1x-1.png)
2015-05-31 20:10:03.654608 I  (0x7f332801d728)::IncrRef() -> 5
2015-05-31 20:10:03.654612 I  (0x7f332801d728)::IncrRef() -> 6
2015-05-31 20:10:03.654615 I  (0x7f332801d728)::DecrRef() -> 5
2015-05-31 20:10:03.654619 I 
ImageLoader::LoadImage(Images-progressbar_fill.png---1x-1.png) 
Found in cache, RefCount = 5
2015-05-31 20:10:03.654886 I  MythSocket(7f330c00c960:63): read 
  <- 63 2       OK
2015-05-31 20:10:03.655451 I  TV: Created TvPlayWindow.
2015-05-31 20:10:03.655528 I  TV: DrawUnusedRects() -- begin
2015-05-31 20:10:03.655536 I  TV: DrawUnusedRects() -- end
2015-05-31 20:10:03.657454 I  TV: DrawUnusedRects() -- begin
2015-05-31 20:10:03.657463 I  TV: DrawUnusedRects() -- end
2015-05-31 20:10:03.657510 I  (0x7f3318033618)::IncrRef() -> 4
2015-05-31 20:10:03.659600 I  (0x7f3318033618)::DecrRef() -> 3
2015-05-31 20:10:03.659648 I  (0x4cc0388)::IncrRef() -> 2
2015-05-31 20:10:03.660947 I  (0x4cc0388)::DecrRef() -> 1
2015-05-31 20:10:03.660986 I  (0x4613d08)::IncrRef() -> 2
2015-05-31 20:10:03.661021 I  (0x4613d08)::DecrRef() -> 1
2015-05-31 20:10:03.662383 I  TV: DrawUnusedRects() -- begin
2015-05-31 20:10:03.662392 I  TV: DrawUnusedRects() -- end
2015-05-31 20:10:03.662431 I  (0x7f3318033618)::IncrRef() -> 4
2015-05-31 20:10:03.663793 I  (0x7f3318033618)::DecrRef() -> 3
2015-05-31 20:10:03.663837 I  (0x4cc0388)::IncrRef() -> 2
2015-05-31 20:10:03.665143 I  (0x4cc0388)::DecrRef() -> 1
2015-05-31 20:10:03.665191 I  (0x4613d08)::IncrRef() -> 2
2015-05-31 20:10:03.665225 I  (0x4613d08)::DecrRef() -> 1
2015-05-31 20:10:03.665289 I  TV: Init -- end
2015-05-31 20:10:03.665305 I  TV: tv->Playback() -- begin
2015-05-31 20:10:03.666010 I  TV: HandleStateChange(0) -- begin
2015-05-31 20:10:03.666028 I  TV: Attempting to change from None 
to WatchingVideo
2015-05-31 20:10:03.666378 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): 
OpenFile(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv, 2000 ms)
2015-05-31 20:10:03.667977 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): OpenFile() made 1 attempts in 1 ms
2015-05-31 20:10:03.667986 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.667995 I  TV: StartPlayer(0, WatchingVideo, 
main) -- begin
2015-05-31 20:10:03.668001 I  TV: Elapsed time since TV 
constructor was called: 25 ms
2015-05-31 20:10:03.668204 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libadjust.so'
2015-05-31 20:10:03.668352 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libbobdeint.so'
2015-05-31 20:10:03.668413 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libcrop.so'
2015-05-31 20:10:03.668471 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libdenoise3d.so'
2015-05-31 20:10:03.668533 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libfieldorder.so'
2015-05-31 20:10:03.668587 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libforce.so'
2015-05-31 20:10:03.668641 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libgreedyhdeint.so'
2015-05-31 20:10:03.668708 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libinvert.so'
2015-05-31 20:10:03.668763 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libivtc.so'
2015-05-31 20:10:03.668814 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libkerneldeint.so'
2015-05-31 20:10:03.668974 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/liblinearblend.so'
2015-05-31 20:10:03.669038 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libonefield.so'
2015-05-31 20:10:03.669101 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libpostprocess.so'
2015-05-31 20:10:03.669286 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libquickdnr.so'
2015-05-31 20:10:03.669347 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libvflip.so'
2015-05-31 20:10:03.669400 I  FilterManager: Loading filter 
'/usr/lib/mythtv/filters/libyadif.so'
2015-05-31 20:10:03.669545 I  playCtx: Output filters for this 
channel are: ''
2015-05-31 20:10:03.677223 I  ALSA: OpenDevice default
2015-05-31 20:10:03.678122 I  AOS: Sample rate 5512 is supported
2015-05-31 20:10:03.678129 I  AOS: Sample rate 8000 is supported
2015-05-31 20:10:03.678134 I  AOS: Sample rate 11025 is supported
2015-05-31 20:10:03.678138 I  AOS: Sample rate 16000 is supported
2015-05-31 20:10:03.678143 I  AOS: Sample rate 22050 is supported
2015-05-31 20:10:03.678146 I  AOS: Sample rate 32000 is supported
2015-05-31 20:10:03.678150 I  AOS: Sample rate 44100 is supported
2015-05-31 20:10:03.678153 I  AOS: Sample rate 48000 is supported
2015-05-31 20:10:03.678158 I  AOS: Sample rate 88200 is supported
2015-05-31 20:10:03.678162 I  AOS: Sample rate 96000 is supported
2015-05-31 20:10:03.678165 I  AOS: Sample rate 176400 is supported
2015-05-31 20:10:03.678169 I  AOS: Sample rate 192000 is supported
2015-05-31 20:10:03.678173 I  AOS: Format unsigned 8 bit is 
supported
2015-05-31 20:10:03.678179 I  AOS: Format signed 16 bit is supported
2015-05-31 20:10:03.678183 I  AOS: Format signed 24 bit MSB is 
supported
2015-05-31 20:10:03.678186 I  AOS: Format signed 32 bit is supported
2015-05-31 20:10:03.678189 I  AOS: Format 32 bit floating point 
is supported
2015-05-31 20:10:03.678196 I  AOS: 1 channel(s) are supported
2015-05-31 20:10:03.678202 I  AOS: 2 channel(s) are supported
2015-05-31 20:10:03.678207 I  AOS: 3 channel(s) are supported
2015-05-31 20:10:03.678211 I  AOS: 4 channel(s) are supported
2015-05-31 20:10:03.678216 I  AOS: 5 channel(s) are supported
2015-05-31 20:10:03.678220 I  AOS: 6 channel(s) are supported
2015-05-31 20:10:03.678224 I  AOS: 7 channel(s) are supported
2015-05-31 20:10:03.678228 I  AOS: 8 channel(s) are supported
2015-05-31 20:10:03.678236 E  ALSA: snd_pcm_info_get_card: 
Operation not permitted
2015-05-31 20:10:03.678239 I  ALSA: Can't get card and device number
2015-05-31 20:10:03.688981 N  AudioPlayer: Enabling Audio
2015-05-31 20:10:03.689000 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.689199 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.689210 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Created readAheadBuffer: 4Mb
2015-05-31 20:10:03.689220 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): ResetReadAhead(internalreadpos = 0->0)
2015-05-31 20:10:03.689232 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.689247 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Initial readblocksize 128K & fill_min 320K
2015-05-31 20:10:03.689442 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 0, 327680) -> 327680, took 0 ms 
(1000Mbps) avg 300 ms
2015-05-31 20:10:03.689472 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Unpause()
2015-05-31 20:10:03.689479 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.689987 I  Player(1): Stretch Factor 1, allow 
passthru
2015-05-31 20:10:03.690240 I  AFD: Buffer size: 32768 streamed 0 
seekable 1
2015-05-31 20:10:03.691747 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Seek(173458421,SEEK_SET,unlocked)
2015-05-31 20:10:03.691755 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StopReads()
2015-05-31 20:10:03.691761 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.691773 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): rbrpos: 32768 rbwpos: 
327680
			readpos: 32768 internalreadpos: 327680
2015-05-31 20:10:03.691794 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): Offset from end: 65307
2015-05-31 20:10:03.691805 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): ResetReadAhead(internalreadpos = 327680->173458421)
2015-05-31 20:10:03.691817 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.694582 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 0, 131072) -> 65307, took 0 ms 
(1000Mbps) avg 270 ms
2015-05-31 20:10:03.699700 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 65307, 131072) -> 0, took 0 ms 
(1000Mbps) avg 270 ms
2015-05-31 20:10:03.704947 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Seek(10573,SEEK_SET,unlocked)
2015-05-31 20:10:03.704952 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StopReads()
2015-05-31 20:10:03.704955 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.704961 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): rbrpos: 65307 rbwpos: 65307
			readpos: 173523728 internalreadpos: 173523728
2015-05-31 20:10:03.704965 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): internal_backbuf: 65307 
sba: 173513155
2015-05-31 20:10:03.704975 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): Offset from end: 173513155
2015-05-31 20:10:03.704980 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): ResetReadAhead(internalreadpos = 173523728->10573)
2015-05-31 20:10:03.704986 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.704998 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Seek(6373,SEEK_SET,unlocked)
2015-05-31 20:10:03.705002 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StopReads()
2015-05-31 20:10:03.705004 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.705010 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): rbrpos: 0 rbwpos: 0
			readpos: 10573 internalreadpos: 10573
2015-05-31 20:10:03.705013 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): internal_backbuf: 0 
sba: 4200
2015-05-31 20:10:03.705020 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): Offset from end: 173517355
2015-05-31 20:10:03.705024 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): ResetReadAhead(internalreadpos = 10573->6373)
2015-05-31 20:10:03.705030 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(8000 Kb)
			 -> threshhold(3584 KB) min read(320 KB) blk size(128 KB)
2015-05-31 20:10:03.709949 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 0, 131072) -> 131072, took 0 ms 
(1000Mbps) avg 270 ms
2015-05-31 20:10:03.715092 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 131072, 131072) -> 131072, took 0 
ms (1000Mbps) avg 243 ms
2015-05-31 20:10:03.720271 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 262144, 131072) -> 131072, took 0 
ms (1000Mbps) avg 219 ms
2015-05-31 20:10:03.720383 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): Seek(10573,SEEK_SET,unlocked)
2015-05-31 20:10:03.720401 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StopReads()
2015-05-31 20:10:03.720405 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): StartReads()
2015-05-31 20:10:03.720411 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): rbrpos: 65536 rbwpos: 
393216
			readpos: 71909 internalreadpos: 399589
2015-05-31 20:10:03.720415 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): internal_backbuf: 65536 
sba: 61336
2015-05-31 20:10:03.720420 I 
FileRingBuf(/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv): Seek(): OPT1 rbrpos: 4200 
rbwpos: 393216
			readpos: 10573 internalreadpos: 399589
2015-05-31 20:10:03.722407 I  AFD: Stream #0, has id 0x0 codec 
id THEORA, type Video, bitrate 0 at 0x4792be0
2015-05-31 20:10:03.722422 I  AFD: Stream #1, has id 0x1 codec 
id VORBIS, type Audio, bitrate 0 at 0x48d3620
2015-05-31 20:10:03.722429 I  AFD: codec VORBIS has 2 channels
2015-05-31 20:10:03.722434 I  AFD: Looking for decoder for VORBIS
2015-05-31 20:10:03.723248 I  AFD: Opened codec 0x56db620, 
id(VORBIS) type(Audio)
2015-05-31 20:10:03.723285 I  AFD: Audio Track #1, of type 
(Normal) is A/V stream #1 (id=0x1) and has 2 channels in the 
Undetermined language(7695972).
2015-05-31 20:10:03.723294 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): UpdateRawBitrate(561Kb)
2015-05-31 20:10:03.723300 W  Enabling buffering optimisations 
for low bitrate stream.
2015-05-31 20:10:03.723310 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): CalcReadAheadThresh(561 Kb)
			 -> threshhold(3584 KB) min read(20 KB) blk size(16 KB)
2015-05-31 20:10:03.723333 I  Player(1): SetFrameInterval ps:1 
scan:3
2015-05-31 20:10:03.723352 I  Player(1): detectInterlace(Ignore 
Scan, Interlaced Scan, 29.97, 0) ->Interlaced Scan
2015-05-31 20:10:03.723373 I  AFD: Selected track 1: 
Undetermined VORBIS 2ch (A/V Stream #1)
2015-05-31 20:10:03.723380 I  AFD: Audio data is planar
2015-05-31 20:10:03.723401 I  AFD: Initializing audio parms from 
audio track #1
2015-05-31 20:10:03.723422 I  AFD: Audio format changed
			from id(NONE)     -1Hz -1ch -1bps     (profile 0) to 
id(VORBIS)  44100Hz  2ch 32bps     (profile 0)
2015-05-31 20:10:03.723435 I  AOBase: Killing AudioOutputDSP
2015-05-31 20:10:03.723446 I  AOBase: Original codec was VORBIS, 
32 bit floating point, 44 kHz, 2 channels
2015-05-31 20:10:03.723462 I  AOBase: enc(0), passthru(0), 
features (LPCM) configured_channels(2), 2 channels supported(1) 
max_channels(2)
2015-05-31 20:10:03.723479 I  AOBase: Opening audio device 
'default' ch 2(2) sr 44100 sf 32 bit floating point reenc 0
2015-05-31 20:10:03.723485 I  ALSA: OpenDevice default
2015-05-31 20:10:03.725186 I  ALSA: SetParameters(format=14, 
channels=2, rate=44100, buffer_time=500000, period_time=4)
2015-05-31 20:10:03.725227 I  ALSA: Buffer size range from 48 to 
524288
2015-05-31 20:10:03.725234 I  ALSA: Period size range from 16 to 
174763
2015-05-31 20:10:03.725245 I  ALSA: Buffer time = 500000 us
2015-05-31 20:10:03.725254 I  ALSA: Period time = 4 periods
2015-05-31 20:10:03.725409 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 393216, 16384) -> 16384, took 0 
ms (1000Mbps) avg 197 ms
2015-05-31 20:10:03.727659 I  ALSA: Buffer size = 22050 | Period 
size = 5512
2015-05-31 20:10:03.730530 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 409600, 16384) -> 16384, took 0 
ms (1000Mbps) avg 177 ms
2015-05-31 20:10:03.733687 E  ALSA: no playback control PCM 
found on mixer device default
2015-05-31 20:10:03.733694 E  ALSA: Unable to open audio mixer. 
Volume control disabled
2015-05-31 20:10:03.733700 I  AOBase: Audio fragment size: 22048
2015-05-31 20:10:03.733708 I  AOBase: Audio Stretch Factor: 1
2015-05-31 20:10:03.733727 I  AOBase: Ending Reconfigure()
2015-05-31 20:10:03.733737 I  Dec: Trying to select track 
(w/lang & forced)
2015-05-31 20:10:03.733748 I  Dec: Selected track #1 (type 4) in 
the Unknown language(0)
2015-05-31 20:10:03.733757 I  Dec: Resyncing position map. 
posmapStarted = 0 livetv(0) watchingRec(0)
2015-05-31 20:10:03.733798 I  AOBase: kickoffOutputAudioLoop: 
pid = 20970
2015-05-31 20:10:03.733814 I  AOBase: OutputAudioLoop: Play Event
2015-05-31 20:10:03.734508 I  Dec: SyncPositionMap prerecorded, 
from DB: 0 entries
2015-05-31 20:10:03.734912 I  AFD: Recording has no position -- 
using libavformat seeking.
2015-05-31 20:10:03.734938 I  AFD: Successfully opened decoder 
for file: "/var/lib/mythtv/videos//Colgate Comedy - 
Abbott_Costello 7 Jan 1951.ogv". novideo(1)
2015-05-31 20:10:03.735639 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 425984, 16384) -> 16384, took 0 
ms (1000Mbps) avg 159 ms
2015-05-31 20:10:03.735662 I  VideoOutput: Allowed renderers: 
xv-blit,xshm,xlib,opengl,opengl-lite,vdpau,openglvaapi
2015-05-31 20:10:03.735691 I  VideoOutput: Allowed renderers 
(filt: ffmpeg): 
xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,openglvaapi
2015-05-31 20:10:03.736200 N  VDP: Ignoring profile item 15 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.736237 N  VDP: Ignoring profile item 16 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.736290 I  VDP: Accepting: cmp(>= 1920 1080) 
dec(ffmpeg) cpus(2) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) deint(linearblend,linearblend) 
filt()
2015-05-31 20:10:03.736315 I  VDP: Accepting: cmp(> 0 0) 
dec(ffmpeg) cpus(1) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) 
deint(yadifdoubleprocessdeint,yadifdeint) filt()
2015-05-31 20:10:03.736325 I  VDP: LoadBestPreferences(2048x2048, 0)
2015-05-31 20:10:03.736341 I  VDP: 
LoadBestPreferences(2048x2048, 60)
2015-05-31 20:10:03.736354 I  VDP: LoadBestPreferences(0x0, 60)
2015-05-31 20:10:03.736378 I  VideoOutput: Trying video 
renderer: 'vdpau'
2015-05-31 20:10:03.737352 N  VDP: Ignoring profile item 15 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.737388 N  VDP: Ignoring profile item 16 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.737437 I  VDP: Accepting: cmp(>= 1920 1080) 
dec(ffmpeg) cpus(2) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) deint(linearblend,linearblend) 
filt()
2015-05-31 20:10:03.737462 I  VDP: Accepting: cmp(> 0 0) 
dec(ffmpeg) cpus(1) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) 
deint(yadifdoubleprocessdeint,yadifdeint) filt()
2015-05-31 20:10:03.737471 I  VDP: LoadBestPreferences(2048x2048, 0)
2015-05-31 20:10:03.737485 I  VDP: 
LoadBestPreferences(2048x2048, 60)
2015-05-31 20:10:03.737501 I  VideoOutWindow::SetPIPState. 
pip_state: 0]
2015-05-31 20:10:03.737509 I  VDP: 
LoadBestPreferences(2048x2048, 29.97)
2015-05-31 20:10:03.737526 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.737532 I  Snapping width to avoid scaling: 
width: 1920, left: 0
2015-05-31 20:10:03.737541 I  Display Rect  left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.737550 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.737558 I  VDP: 
LoadBestPreferences(1920x1056, 29.97)
2015-05-31 20:10:03.737572 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.737577 I  Snapping width to avoid scaling: 
width: 1920, left: 0
2015-05-31 20:10:03.737585 I  Display Rect  left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.737593 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.737598 I  VDP: SetVideoRenderer(vdpau)
2015-05-31 20:10:03.737611 I  VDP: Old preferences: 
rend(xv-blit) osd(softblend) 
deint(yadifdoubleprocessdeint,yadifdeint) filt()
2015-05-31 20:10:03.737636 I  VDP: New preferences: rend(vdpau) 
osd(vdpau) deint(none,none) filt()
2015-05-31 20:10:03.738100 I  VideoOutput: Pixel dimensions: 
Screen 1920x1080, window 1920x1056
2015-05-31 20:10:03.738122 I  VideoOutput: Actual display 
dimensions: 508x285 mm  Aspect: 1.78246
2015-05-31 20:10:03.738135 I  VideoOutput: Estimated window 
dimensions: 508x278 mm  Aspect: 1.82734
2015-05-31 20:10:03.738858 E  VDPAU: Error at 
mythrender_vdpau.cpp:1581 (#1, Unknown)
2015-05-31 20:10:03.738865 E  VDPAU: Failed to create VDPAU device.
2015-05-31 20:10:03.738868 E  VDPAU: No VDPAU device
2015-05-31 20:10:03.738872 E  VDPAU: Failed to create VDPAU 
render device.
2015-05-31 20:10:03.738877 E  VidOutVDPAU: Failed to initialise 
VDPAU
2015-05-31 20:10:03.738883 I  VidOutVDPAU: DiscardFrames(1)
2015-05-31 20:10:03.738891 I  VideoBuffers::DiscardFrames(1):
2015-05-31 20:10:03.738912 I  VideoBuffers::DiscardFrames(1): -- 
done
2015-05-31 20:10:03.738918 I  VidOutVDPAU: DiscardFrames() 3: -- 
done()
2015-05-31 20:10:03.738929 I  (0x47f4f80)::DecrRef() -> 0
2015-05-31 20:10:03.739018 I  VidOutVDPAU: DiscardFrames(1)
2015-05-31 20:10:03.739036 I  VideoBuffers::DiscardFrames(1):
2015-05-31 20:10:03.739055 I  VideoBuffers::DiscardFrames(1): -- 
done
2015-05-31 20:10:03.739064 I  VidOutVDPAU: DiscardFrames() 3: -- 
done()
2015-05-31 20:10:03.739089 I  VideoOutput: Trying video 
renderer: 'openglvaapi'
2015-05-31 20:10:03.740246 N  VDP: Ignoring profile item 15 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.740282 N  VDP: Ignoring profile item 16 
(renderer quartz-blit is not supported w/decoder ffmpeg 
(supported: 
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2015-05-31 20:10:03.740332 I  VDP: Accepting: cmp(>= 1920 1080) 
dec(ffmpeg) cpus(2) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) deint(linearblend,linearblend) 
filt()
2015-05-31 20:10:03.740358 I  VDP: Accepting: cmp(> 0 0) 
dec(ffmpeg) cpus(1) skiploop(disabled) rend(xv-blit) 
osd(softblend) osdfade(enabled) 
deint(yadifdoubleprocessdeint,yadifdeint) filt()
2015-05-31 20:10:03.740367 I  VDP: LoadBestPreferences(2048x2048, 0)
2015-05-31 20:10:03.740382 I  VDP: 
LoadBestPreferences(2048x2048, 60)
2015-05-31 20:10:03.740397 I  VideoOutWindow::SetPIPState. 
pip_state: 0]
2015-05-31 20:10:03.740404 I  VDP: 
LoadBestPreferences(2048x2048, 29.97)
2015-05-31 20:10:03.740418 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.740423 I  Snapping width to avoid scaling: 
width: 1920, left: 0
2015-05-31 20:10:03.740432 I  Display Rect  left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.740441 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.740448 I  VDP: 
LoadBestPreferences(1920x1056, 29.97)
2015-05-31 20:10:03.740461 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.740467 I  Snapping width to avoid scaling: 
width: 1920, left: 0
2015-05-31 20:10:03.740475 I  Display Rect  left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.740482 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.740487 I  VDP: SetVideoRenderer(openglvaapi)
2015-05-31 20:10:03.740499 I  VDP: Old preferences: 
rend(xv-blit) osd(softblend) 
deint(yadifdoubleprocessdeint,yadifdeint) filt()
2015-05-31 20:10:03.740524 I  VDP: New preferences: 
rend(openglvaapi) osd(opengl2) 
deint(vaapionefield,vaapionefield) filt()
2015-05-31 20:10:03.740747 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 442368, 16384) -> 16384, took 0 
ms (1000Mbps) avg 143 ms
2015-05-31 20:10:03.745905 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 458752, 16384) -> 16384, took 0 
ms (1000Mbps) avg 129 ms
2015-05-31 20:10:03.766204 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 475136, 16384) -> 16384, took 0 
ms (1000Mbps) avg 116 ms
2015-05-31 20:10:03.768513 W  OpenGL: Could not determine 
whether Sync to VBlank is enabled.
2015-05-31 20:10:03.771344 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 491520, 16384) -> 16384, took 0 
ms (1000Mbps) avg 106 ms
2015-05-31 20:10:03.776483 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 507904, 16384) -> 16384, took 0 
ms (1000Mbps) avg 95 ms
2015-05-31 20:10:03.778863 I  OpenGL1: Fragment program support 
available
2015-05-31 20:10:03.778885 I  OpenGL: PixelBufferObject support 
available
2015-05-31 20:10:03.778887 I  OpenGL: Initialised MythRenderOpenGL
2015-05-31 20:10:03.778893 I  VidOutGL: Created MythRenderOpenGL 
device.
2015-05-31 20:10:03.779208 I  VideoOutput: Pixel dimensions: 
Screen 1920x1080, window 1920x1056
2015-05-31 20:10:03.779223 I  VideoOutput: Actual display 
dimensions: 508x285 mm  Aspect: 1.78246
2015-05-31 20:10:03.779229 I  VideoOutput: Estimated window 
dimensions: 508x278 mm  Aspect: 1.82734
2015-05-31 20:10:03.779250 I  MythPainter cache sizes: Hardware 
96 MB, Software 96 MB
2015-05-31 20:10:03.779261 I  OpenGL painter using existing 
OpenGL context.
2015-05-31 20:10:03.779263 I  OpenGL painter using existing 
QGLWidget.
2015-05-31 20:10:03.779309 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.779318 I  Display Rect  left: 240, top: 0, 
width: 1440, height: 1056, aspect: 1.77778
2015-05-31 20:10:03.779324 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.779340 I  Over/underscan. V: 0, H: 0
2015-05-31 20:10:03.779345 I  Snapping height to avoid scaling: 
height: 1056, top: 0
2015-05-31 20:10:03.779351 I  Display Rect  left: 240, top: 0, 
width: 1440, height: 1056, aspect: 1.77778
2015-05-31 20:10:03.779357 I  Video Rect    left: 0, top: 0, 
width: 1920, height: 1056, aspect: 1.33333
2015-05-31 20:10:03.779377 I  Player(1): LoadFilters(''..) -> 0x0
2015-05-31 20:10:03.779898 I  XMLParseBase: Loading window 
osd_message from /home/napier/.mythtv/themes/Steppes/osd.xml
2015-05-31 20:10:03.779945 I  MythSocket(7f330c00c960:63): write 
-> 63 72      MESSAGE[]:[]SYSTEM_EVENT SCREEN_TYPE CREATED 
osd_message SENDER c...
2015-05-31 20:10:03.779957 I  Player(1): Decoder thread starting.
2015-05-31 20:10:03.780264 I  MythSocket(7f330c00c960:63): read 
  <- 63 2       OK
2015-05-31 20:10:03.781577 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 524288, 16384) -> 16384, took 0 
ms (1000Mbps) avg 86 ms
2015-05-31 20:10:03.782612 I  OSD: Loaded window osd_message
2015-05-31 20:10:03.782634 I  XMLParseBase: Loading window 
osd_input from /home/napier/.mythtv/themes/Steppes/osd.xml
2015-05-31 20:10:03.782662 I  MythSocket(7f330c00c960:63): write 
-> 63 70      MESSAGE[]:[]SYSTEM_EVENT SCREEN_TYPE CREATED 
osd_input SENDER col...
2015-05-31 20:10:03.782853 I  MythSocket(7f330c00c960:63): read 
  <- 63 2       OK
2015-05-31 20:10:03.785147 I  OSD: Loaded window osd_input
2015-05-31 20:10:03.785167 I  XMLParseBase: Loading window 
program_info from /home/napier/.mythtv/themes/Steppes/osd.xml
2015-05-31 20:10:03.785191 I  MythSocket(7f330c00c960:63): write 
-> 63 73      MESSAGE[]:[]SYSTEM_EVENT SCREEN_TYPE CREATED 
program_info SENDER ...
2015-05-31 20:10:03.785420 I  MythSocket(7f330c00c960:63): read 
  <- 63 2       OK
2015-05-31 20:10:03.786658 I 
RingBuf(/var/lib/mythtv/videos//Colgate Comedy - Abbott_Costello 
7 Jan 1951.ogv): safe_read(... at 540672, 16384) -> 16384, took 0 
ms (1000Mbps) avg 77 ms
2015-05-31 20:10:03.788013 I  MythUIHelper: 
LoadCacheImage(Images/Arclight/LiveTV.png,Images-Arclight-LiveTV.png--200x61.png)
2015-05-31 20:10:03.788026 I  (0x7f33180108a8)::IncrRef() -> 2
2015-05-31 20:10:03.788057 I  (0x7f33180108a8)::DecrRef() -> 1
2015-05-31 20:10:03.788069 I  MythUIHelper: 
LoadCacheImage(Images/Arclight/LiveTV.png,Images-Arclight-LiveTV.png--200x61.png)
2015-05-31 20:10:03.788074 I  (0x7f33180108a8)::IncrRef() -> 2
2015-05-31 20:10:03.788077 I  (0x7f33180108a8)::IncrRef() -> 3


More information about the mythtv-users mailing list