Streaming goes to the backend instead of the phone
32 views
Skip to first unread message
pete
Sep 13, 2011, 11:48:47 PM9/13/11
to mythdroid-users
Hi,
I'm really enjoying mythdroid after having just found it. Great work!
I'm having trouble streaming recordings to the phone. My setup has a
(slow) master backend and a (fast) slave backend. I'm trying to
stream from the slave backend to the phone. Everything else (remote
related) seems to work. However, on pushing "Here" for a recording, I
get the "Sorry, this video cannot be played" error on the phone and
the video displays on the backend screen. The display looks fine. (It
is not playing on the frontend instance, just displayed on screen).
All this on gentoo boxes with mythtv-0.24.1, mdd and mythdroid 0.5.1,
on an Inspire
Below is my /tmp/vlc.out and files. I've clipped them just a bit but
the relevant stuff should be there.
cat /tmp/mdd.log
Tue 13 Sep 23:35:02 - Warning - VLC: frame sync error
Tue 13 Sep 23:35:02 - Warning - VLC: [0x7f0174002530] main video
output error: picture to display 0x7f0174002ae0 has invalid status 2
Tue 13 Sep 23:35:02 - Warning - VLC: [0x7f0174002530] main video
output error: picture to display 0x7f0174002ae0 has invalid status 2
Tue 13 Sep 23:35:19 - Warning - VLC: frame sync error
Tue 13 Sep 23:38:07 - Warning - VLC: [0x2d2cf70] main video output
error: Encoding support not compiled-in!
Tue 13 Sep 23:38:07 - Warning - VLC: [0x2d2cf70] main video output
error: Failed to convert image for snapshot
Tue 13 Sep 23:39:04 - Warning - VLC: frame sync error
Tue 13 Sep 23:39:09 - Warning - VLC: frame sync error
Tue 13 Sep 23:39:10 - Warning - VLC: [0x2d2cf70] main video output
error: picture to display 0x2d2f410 has invalid status 2
Tue 13 Sep 23:39:24 - Warning - VLC: frame sync error
cat /tmp/vlc.out
VLC media player 1.1.11 The Luggage (revision exported)
[0x1d9e120] main libvlc debug: VLC media player - 1.1.11 The Luggage
[0x1d9e120] main libvlc debug: Copyright © 1996-2011 the VideoLAN team
[0x1d9e120] main libvlc debug: revision exported
[0x1d9e120] main libvlc debug: configured with ./configure '--prefix=/
usr' '--build=x86_64-pc-linux-gnu' '--host=x86_64-pc-linux-gnu' '--
mandir=/usr/share/man' '--infodir=/usr/share/info' '--datadir=/usr/
share' '--sysconfdir=/etc' '--localstatedir=/var/lib' '--libdir=/usr/
lib64' '--disable-a52' '--disable-aa' '--enable-faad' '--enable-alsa'
'--disable-altivec' '--disable-asademux' '--disable-atmo' '--disable-
bonjour' '--disable-fribidi' '--disable-vcd' '--disable-libcddb' '--
enable-dbus' '--enable-dbus-control' '--disable-dirac' '--disable-
directfb' '--disable-dc1394' '--disable-debug' '--disable-dca' '--
disable-dvb' '--enable-dvdread' '--enable-dvdnav' '--disable-fb' '--
enable-avcodec' '--enable-avformat' '--enable-swscale' '--enable-
postproc' '--enable-flac' '--disable-fluidsynth' '--disable-
fontconfig' '--disable-ggi' '--disable-gme' '--disable-gnomevfs' '--
disable-gnutls' '--disable-httpd' '--disable-id3tag' '--disable-dv' '--
disable-jack' '--disable-kate' '--with-kde-solid' '--disable-libass'
'--disable-caca' '--enable-libgcrypt' '--disable-notify' '--disable-
libproxy' '--disable-libtar' '--disable-tiger' '--disable-libv4l' '--
disable-libv4l2' '--disable-lirc' '--disable-live555' '--disable-lua'
'--disable-mkv' '--enable-mmx' '--disable-mod' '--enable-mad' '--
enable-libmpeg2' '--disable-mtp' '--disable-mpc' '--enable-ncurses' '--
enable-mozilla' '--with-mozilla-pkg=libxul' '--enable-ogg' '--enable-
glx' '--enable-opengl' '--disable-optimize-memory' '--disable-oss' '--
enable-png' '--disable-portaudio' '--disable-projectm' '--enable-
pulse' '--disable-pvr' '--enable-qt4' '--disable-remoteosd' '--disable-
realrtsp' '--disable-run-as-root' '--disable-smb' '--disable-
schroedinger' '--enable-sdl' '--disable-sdl-image' '--disable-shine'
'--disable-shout' '--disable-skins2' '--disable-speex' '--disable-
sqlite' '--enable-sse' '--disable-sout' '--enable-svg' '--disable-
svgalib' '--disable-taglib' '--disable-theora' '--enable-freetype' '--
disable-twolame' '--disable-udev' '--disable-upnp' '--enable-v4l' '--
disable-v4l2' '--disable-vcdx' '--disable-libva' '--disable-vlm' '--
enable-vorbis' '--disable-loader' '--disable-wma-fixed' '--enable-
x264' '--enable-libxml2' '--disable-xosd' '--disable-xvideo' '--
disable-zvbi' '--enable-telx' '--disable-snapshot' '--disable-growl'
'--disable-optimizations' '--enable-fast-install' '--enable-xcb' '--
with-x' 'build_alias=x86_64-pc-linux-gnu' 'host_alias=x86_64-pc-linux-
gnu' 'CFLAGS=-march=native -O2 -pipe' 'LDFLAGS=' 'CXXFLAGS=-
march=native -O2 -pipe' 'PKG_CONFIG_PATH=/usr/lib64/pkgconfig'
[0x1d9e120] main libvlc debug: translation test: code is "C"
[0x1d9e120] main libvlc debug: checking plugin modules
[0x1d9e120] main libvlc debug: loading plugins cache file /usr/lib64/
vlc/plugins/plugins-04081e-fe8.dat
[0x1d9e120] main libvlc debug: recursively browsing `/usr/lib64/vlc/
plugins'
[0x1d9e120] main libvlc debug: saving plugins cache /usr/lib64/vlc/
plugins/plugins-04081e-fe8.dat
[0x1d9e120] main libvlc debug: module bank initialized (291 modules)
[0x1d9e120] main libvlc debug: opening config file (/home/pete/.config/
vlc/vlcrc)
[0x1d9e120] main libvlc debug: CPU has capabilities MMX MMXEXT SSE
SSE2 SSE3 SSSE3 SSE4.1 SSE4.2 FPU
[0x1d9e120] main libvlc debug: looking for memcpy module: 3 candidates
[0x1d9e120] main libvlc debug: using memcpy module "memcpymmxext"
[0x1e467f0] main input debug: Creating an input for 'Media Library'
[0x1e467f0] main input debug: Input is a meta file: disabling unneeded
options
[0x1e467f0] main input debug: using timeshift granularity of 50 MiB
[0x1e467f0] main input debug: using timeshift path '/tmp'
[0x1e467f0] main input debug: `file/xspf-open:///home/pete/.local/
share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/
pete/.local/share/vlc/ml.xspf'
[0x1e467f0] main input debug: creating demux: access='file'
demux='xspf-open' path='/home/pete/.local/share/vlc/ml.xspf'
[0x1fb7c70] main demux debug: looking for access_demux module: 2
candidates
[0x1fb7c70] main demux debug: no access_demux module matching "file"
could be loaded
[0x1fb7c70] main demux debug: TIMER module_need() : 0.142 ms - Total
0.142 ms / 1 intvls (Avg 0.142 ms)
[0x1e467f0] main input debug: creating access 'file' path='/home/
pete/.local/share/vlc/ml.xspf'
[0x1fb80f0] main access debug: looking for access module: 2 candidates
[0x1fb80f0] filesystem access debug: opening file `/home/pete/.local/
share/vlc/ml.xspf'
[0x1fb80f0] main access debug: using access module "filesystem"
[0x1fb80f0] main access debug: TIMER module_need() : 0.136 ms - Total
0.136 ms / 1 intvls (Avg 0.136 ms)
[0x1fb8480] main stream debug: Using AStream*Stream
[0x1fb8480] main stream debug: pre buffering
[0x1fb8480] main stream debug: received first data after 0 ms
[0x1fb8480] main stream debug: pre-buffering done 296 bytes in 0s -
26278 KiB/s
[0x1fb86f0] main stream debug: looking for stream_filter module: 5
candidates
[0x1fb86f0] main stream debug: no stream_filter module matching "any"
could be loaded
[0x1fb86f0] main stream debug: TIMER module_need() : 0.085 ms - Total
0.085 ms / 1 intvls (Avg 0.085 ms)
[0x1fb86f0] main stream debug: looking for stream_filter module: 1
candidate
[0x1fb86f0] main stream debug: using stream_filter module
"stream_filter_record"
[0x1fb86f0] main stream debug: TIMER module_need() : 0.079 ms - Total
0.079 ms / 1 intvls (Avg 0.079 ms)
[0x1e467f0] main input debug: creating demux: access='file'
demux='xspf-open' path='/home/pete/.local/share/vlc/ml.xspf'
[0x1fb89f0] main demux debug: looking for demux module: 1 candidate
[0x1fb89f0] playlist demux debug: using XSPF playlist reader
[0x1fb89f0] main demux debug: using demux module "playlist"
[0x1fb89f0] main demux debug: TIMER module_need() : 0.100 ms - Total
0.100 ms / 1 intvls (Avg 0.100 ms)
[0x1fb8dc0] main demux meta debug: looking for meta reader module: 0
candidates
[0x1fb8dc0] main demux meta debug: no meta reader module matched "any"
[0x1fb8dc0] main demux meta debug: TIMER module_need() : 0.064 ms -
Total 0.064 ms / 1 intvls (Avg 0.064 ms)
[0x1e467f0] main input debug: `file/xspf-open:///home/pete/.local/
share/vlc/ml.xspf' successfully opened
[0x1fb8d10] main xml debug: looking for xml module: 2 candidates
[0x1fb8d10] main xml debug: using xml module "xml"
[0x1fb8d10] main xml debug: TIMER module_need() : 0.138 ms - Total
0.138 ms / 1 intvls (Avg 0.138 ms)
[0x1fb89f0] playlist demux debug: parsed 0 tracks successfully
[0x1fb8d10] main xml debug: removing module "xml"
[0x1e467f0] main input debug: EOF reached
[0x1fb89f0] main demux debug: removing module "playlist"
[0x1fb86f0] main stream debug: removing module "stream_filter_record"
[0x1fb80f0] main access debug: removing module "filesystem"
[0x1e467f0] main input debug: TIMER input launching for 'Media
Library' : 1.471 ms - Total 1.471 ms / 1 intvls (Avg 1.471 ms)
[0x1e469d0] main interface debug: looking for interface module: 1
candidate
[0x1e469d0] main interface debug: using interface module "hotkeys"
[0x1e469d0] main interface debug: TIMER module_need() : 0.091 ms -
Total 0.091 ms / 1 intvls (Avg 0.091 ms)
[0x1e47d10] main interface debug: looking for interface module: 1
candidate
Blocked: call to unsetenv("DBUS_ACTIVATION_ADDRESS")
Blocked: call to unsetenv("DBUS_ACTIVATION_BUS_TYPE")
[0x1db0310] main playlist debug: Activated
[0x1e47d10] main interface debug: using interface module "inhibit"
[0x1e47d10] main interface debug: TIMER module_need() : 1.003 ms -
Total 1.003 ms / 1 intvls (Avg 1.003 ms)
[0x1db0310] main playlist debug: adding item
`2171_20110913010000.mpg' ( file:///home/mythtv//2171_20110913010000.mpg
)
[0x1db0310] main playlist debug: rebuilding array of current - root
Playlist
[0x1db0310] main playlist debug: rebuild done - 0 items, index -1
[0x1e48b60] main input debug: Creating an input for
'2171_20110913010000.mpg'
[0x1fb6ee0] main interface debug: looking for interface module: 1
candidate
[0x1fb6ee0] main interface debug: using interface module "signals"
[0x1fb6ee0] main interface debug: TIMER module_need() : 0.124 ms -
Total 0.124 ms / 1 intvls (Avg 0.124 ms)
[0x1e48640] main interface debug: looking for interface module: 1
candidate
[0x1e48640] main interface debug: using interface module
"globalhotkeys"
[0x1e48640] main interface debug: TIMER module_need() : 0.433 ms -
Total 0.433 ms / 1 intvls (Avg 0.433 ms)
[0x1e48dc0] main interface debug: looking for interface module: 1
candidate
[0x1e48dc0] oldrc interface debug: base: 0.0.0.0, port: 16547
[0x1e48dc0] main interface debug: net: listening to 0.0.0.0 port 16547
Remote control interface initialized. Type `help' for help.
[0x1e48dc0] main interface debug: using interface module "oldrc"
[0x1e48dc0] main interface debug: TIMER module_need() : 0.190 ms -
Total 0.190 ms / 1 intvls (Avg 0.190 ms)
[0x1e48dc0] main interface debug: thread (interface) created at
priority 0 (interface/interface.c:164)
[0x1e48dc0] main interface debug: thread started
[0x1db0310] main playlist debug: processing request item null node
Playlist skip 0
[0x1db0310] main playlist debug: rebuilding array of current - root
Playlist
[0x1db0310] main playlist debug: rebuild done - 1 items, index -1
[0x1db0310] main playlist debug: starting new item
[0x1db0310] main playlist debug: creating new input thread
[0x1fb7870] main input debug: Creating an input for
'2171_20110913010000.mpg'
[0x1fb7870] main input debug: thread (input) created at priority 10
(input/input.c:220)
[0x1fb7870] main input debug: thread started
[0x1fb7870] main input debug: using timeshift granularity of 50 MiB
[0x1fb7870] main input debug: using timeshift path '/tmp'
[0x1fb7870] main input debug: `file:///home/mythtv//
2171_20110913010000.mpg' gives access `file' demux `' path `/home/
mythtv//2171_20110913010000.mpg'
[0x1fb7870] main input debug: enforced demux ` avformat'
[0x1fb7870] main input debug: creating demux: access='file'
demux='avformat' path='/home/mythtv//2171_20110913010000.mpg'
[0x2088920] main demux debug: looking for access_demux module: 2
candidates
[0x2088920] main demux debug: no access_demux module matching "file"
could be loaded
[0x2088920] main demux debug: TIMER module_need() : 7.612 ms - Total
7.612 ms / 1 intvls (Avg 7.612 ms)
[0x1fb7870] main input debug: creating access 'file' path='/home/
mythtv//2171_20110913010000.mpg'
[0x2088fd0] main access debug: looking for access module: 2 candidates
[0x2088fd0] filesystem access debug: opening file `/home/mythtv//
2171_20110913010000.mpg'
[0x2088fd0] main access debug: using access module "filesystem"
[0x2088fd0] main access debug: TIMER module_need() : 1.523 ms - Total
1.523 ms / 1 intvls (Avg 1.523 ms)
[0x20893d0] main stream debug: Using AStream*Stream
[0x20893d0] main stream debug: pre buffering
[0x20893d0] main stream debug: received first data after 14 ms
[0x20893d0] main stream debug: pre-buffering done 1024 bytes in 0s -
67 KiB/s
[0x7fa6840072f0] main stream debug: looking for stream_filter module:
5 candidates
[0x7fa6840072f0] main stream debug: no stream_filter module matching
"any" could be loaded
[0x7fa6840072f0] main stream debug: TIMER module_need() : 0.165 ms -
Total 0.165 ms / 1 intvls (Avg 0.165 ms)
[0x1fbacd0] main stream debug: looking for stream_filter module: 1
candidate
[0x1fbacd0] main stream debug: using stream_filter module
"stream_filter_record"
[0x1fbacd0] main stream debug: TIMER module_need() : 0.087 ms - Total
0.087 ms / 1 intvls (Avg 0.087 ms)
[0x1fb7870] main input debug: creating demux: access='file'
demux='avformat' path='/home/mythtv//2171_20110913010000.mpg'
[0x1fbafe0] main demux debug: looking for demux module: 1 candidate
[0x1fbafe0] avformat demux debug: detected format: mpegts
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpegts @ 0x3893130] max_analyze_duration 5000000 reached at 5003333
[0x1e48dc0] main interface debug: accepted socket 10 (from socket 6)
[0x1fb7870] main input debug: selecting program id=0
[0x1fbafe0] avformat demux debug: adding es: video codec = mpgv
[0x1fbafe0] avformat demux debug: adding es: audio codec = a52
[0x1fbafe0] avformat demux debug: adding es: audio codec = a52
[0x1fbafe0] avformat demux debug: AVFormat supported stream
[0x1fbafe0] avformat demux debug: - format = mpegts (MPEG-2
transport stream format)
[0x1fbafe0] avformat demux debug: - start time = 61546227389
[0x1fbafe0] avformat demux debug: - duration = 1826363123
[0x1fbafe0] main demux debug: using demux module "avformat"
[0x1fbafe0] main demux debug: TIMER module_need() : 4262.916 ms -
Total 4262.916 ms / 1 intvls (Avg 4262.916 ms)
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[0x1fb7870] main input debug: looking for a subtitle file in /home/
mythtv//
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[0x3889f90] main decoder debug: looking for decoder module: 25
candidates
[mpegts @ 0x7fa6840107c0] max_analyze_duration 5000000 reached at
5003333
[0x3889f90] avcodec decoder debug: libavcodec initialized (interface
0x347a00)
[0x1db0310] main playlist debug: no fetch required for (null) (art
currently (null))
[0x3889f90] avcodec decoder debug: trying to use direct rendering
[0x3889f90] avcodec decoder debug: ffmpeg codec (MPEG-1/2 Video)
started
[0x3889f90] main decoder debug: using decoder module "avcodec"
[0x3889f90] main decoder debug: TIMER module_need() : 43.483 ms -
Total 43.483 ms / 1 intvls (Avg 43.483 ms)
[0x3889f90] main decoder debug: thread (decoder) created at priority 0
(input/decoder.c:301)
[0x3889f90] main decoder debug: thread started
[0x38a72b0] main decoder debug: looking for decoder module: 25
candidates
[0x38a72b0] avcodec decoder debug: libavcodec already initialized
[0x38a72b0] avcodec decoder debug: ffmpeg codec (A52 Audio (aka AC3))
started
[0x38a72b0] avcodec decoder debug: Using 192000 bytes output buffer
[0x38a72b0] main decoder debug: using decoder module "avcodec"
[0x38a72b0] main decoder debug: TIMER module_need() : 1.667 ms - Total
1.667 ms / 1 intvls (Avg 1.667 ms)
[0x38a72b0] main decoder debug: thread (decoder) created at priority 5
(input/decoder.c:301)
[0x38a72b0] main decoder debug: thread started
[0x38a8500] main demux meta debug: looking for meta reader module: 0
candidates
[0x38a8500] main demux meta debug: no meta reader module matched "any"
[0x38a8500] main demux meta debug: TIMER module_need() : 0.072 ms -
Total 0.072 ms / 1 intvls (Avg 0.072 ms)
[0x1fb7870] main input debug: `file:///home/mythtv//
2171_20110913010000.mpg' successfully opened
[0x1fb7870] main input debug: Buffering 0%
[0x1fb7870] main input debug: Buffering 0%
[0x1fb7870] main input debug: no usable vout present, spawning one
[0x1fb7870] main input debug: Buffering 1%
[0x7fa684001fb0] main spu text debug: looking for text renderer
module: 3 candidates
[0x1fb7870] main input debug: Buffering 1%
[0x1fb7870] main input debug: Buffering 2%
[0x7fa684001fb0] freetype spu text debug: using fontsize: 2
[0x7fa684001fb0] main spu text debug: using text renderer module
"freetype"
[0x7fa684001fb0] main spu text debug: TIMER module_need() : 0.392 ms -
Total 0.392 ms / 1 intvls (Avg 0.392 ms)
[0x2d36f30] main scale debug: looking for video filter2 module: 18
candidates
[0x1fb7870] main input debug: Buffering 2%
[0x1fb7870] main input debug: Buffering 3%
[0x2d36f30] swscale scale debug: 32x32 chroma: YUVA -> 16x16 chroma:
YUVA with scaling using Bicubic (good quality)
[0x2d36f30] main scale debug: using video filter2 module "swscale"
[0x1fb7870] main input debug: Buffering 4%
[0x2d36f30] main scale debug: TIMER module_need() : 0.440 ms - Total
0.440 ms / 1 intvls (Avg 0.440 ms)
[0x2d41a00] main scale debug: looking for video filter2 module: 18
candidates
[0x2d41a00] yuvp scale debug: YUVP to YUVA converter
[0x2d41a00] main scale debug: using video filter2 module "yuvp"
[0x2d41a00] main scale debug: TIMER module_need() : 0.106 ms - Total
0.106 ms / 1 intvls (Avg 0.106 ms)
[0x2d2cf70] main video output debug: window size: 1280x720
[0x2d2cf70] main video output debug: Deinterlacing available
[0x2d2cf70] main video output debug: deinterlace 0, mode blend,
is_needed 0
[0x2d2cf70] main video output debug: looking for video output module:
1 candidate
[0x2d2cf70] vout_wrapper video output debug: Opening vout display
wrapper
[0x2d00da0] main generic debug: looking for vout display module: 4
candidates
[0x1fb7870] main input debug: Buffering 4%
[0x2d01270] main window debug: looking for vout window xid module: 3
candidates
[0x2d01270] qt4 window debug: Qt4 interface not found
[0x1fb7870] main input debug: Buffering 5%
[0x1fb7870] main input debug: Buffering 6%
[0x2d01270] main window debug: using vout window xid module
"xcb_window"
[0x2d01270] main window debug: TIMER module_need() : 0.783 ms - Total
0.783 ms / 1 intvls (Avg 0.783 ms)
[0x2d04bc0] main inhibit debug: looking for inhibit module: 2
candidates
[0x2d04bc0] main inhibit debug: using inhibit module "xdg_screensaver"
[0x2d04bc0] main inhibit debug: TIMER module_need() : 0.099 ms - Total
0.099 ms / 1 intvls (Avg 0.099 ms)
[0x2d04bc0] xdg_screensaver inhibit debug: started xdg-screensaver
(PID = 7565)
[0x1fb7870] main input debug: Buffering 7%
[0x1fb7870] main input debug: Buffering 52%
[0x2d00da0] xcb_x11 generic debug: connected to X11.0 server
[0x2d00da0] xcb_x11 generic debug: vendor : The X.Org Foundation
[0x2d00da0] xcb_x11 generic debug: version: 11004000
[0x1fb7870] main input debug: Buffering 52%
[0x1fb7870] main input debug: Buffering 53%
[0x2d00da0] xcb_x11 generic debug: using screen 0x15a
[0x2d00da0] xcb_x11 generic debug: X11 visual with alpha-channel not
supported
[0x2d00da0] xcb_x11 generic debug: using X11 visual ID 0x21
[0x2d00da0] xcb_x11 generic debug: 24 bits depth
[0x2d00da0] xcb_x11 generic debug: 32 bits per pixel
[0x2d00da0] xcb_x11 generic debug: 32 bits line pad
[0x1fb7870] main input debug: Buffering 54%
[0x1fb7870] main input debug: Buffering 54%
[0x1fb7870] main input debug: Buffering 55%
[0x1fb7870] main input debug: Buffering 55%
[0x1fb7870] main input debug: Buffering 56%
[0x2d00da0] xcb_x11 generic debug: using X11 window 06a00000
[0x2d00da0] xcb_x11 generic debug: using X11 graphic context 06a00001
[0x1fb7870] main input debug: Buffering 56%
[0x1fb7870] main input debug: Buffering 57%
[0x2d00da0] main generic debug: VoutDisplayEvent 'fullscreen' 0
[0x2d00da0] main generic debug: VoutDisplayEvent 'resize' 1280x720
window
[0x2d00da0] main generic debug: using vout display module "xcb_x11"
[0x2d00da0] main generic debug: TIMER module_need() : 14.409 ms -
Total 14.409 ms / 1 intvls (Avg 14.409 ms)
[0x2d00da0] main generic debug: A filter to adapt decoder to display
is needed
[0x1fb7870] main input debug: Buffering 58%
[0x1fb7870] main input debug: Buffering 58%
[0x2d05ab0] main filter debug: looking for video filter2 module: 18
candidates
[0x1fb7870] main input debug: Buffering 59%
[0x2d05ab0] swscale filter debug: 1280x720 chroma: I420 -> 1280x720
chroma: RV32 with scaling using Bicubic (good quality)
[0x2d05ab0] main filter debug: using video filter2 module "swscale"
[0x2d05ab0] main filter debug: TIMER module_need() : 0.235 ms - Total
0.235 ms / 1 intvls (Avg 0.235 ms)
[0x2d00da0] main generic debug: Filter 'Swscale' (0x2d05ab0) appended
to chain
[0x2d2cf70] main video output debug: using video output module
"vout_wrapper"
[0x2d2cf70] main video output debug: TIMER module_need() : 14.885 ms -
Total 14.885 ms / 1 intvls (Avg 14.885 ms)
[0x1fb7870] main input debug: Buffering 59%
[0x2d2cf70] main video output debug: got 1 direct buffer(s)
[0x2d2cf70] main video output debug: pic render sz 1280x720, of (0,0),
vsz 1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x2d2cf70] main video output debug: pic in sz 1280x720, of (0,0), vsz
1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x1fb7870] main input debug: Buffering 60%
[0x2d2cf70] main video output debug: pic out sz 1280x720, of (0,0),
vsz 1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x2d2cf70] main video output debug: direct render, mapping render
pictures 0-23 to system pictures 1-24
[0x1fb7870] main input debug: Buffering 60%
[0x3889f90] avcodec decoder debug: using direct rendering
warning: first frame is no keyframe
[0x1fb7870] main input debug: creating aout
[0x7fa6840011a0] main audio output debug: looking for audio output
module: 4 candidates
[0x7fa6840011a0] pulse audio output debug: using ? channel map
[0x1fb7870] main input debug: Buffering 61%
[0x1fb7870] main input debug: Buffering 79%
[0x3889f90] main decoder debug: End of video preroll
[0x3889f90] main decoder debug: Received first picture
[0x2d00da0] xcb_x11 generic debug: display is visible
[0x1fb7870] main input debug: Buffering 80%
[0x1fb7870] main input debug: Buffering 99%
[0x1fb7870] main input debug: Stream buffering done (2902 ms in 27 ms)
[0x7fa6840011a0] pulse audio output debug: connected to device
alsa_output.pci-0000_01_00.0.analog-stereo (0)
[0x7fa6840011a0] pulse audio output debug: using buffer metrics:
maxlength=4194312, tlength=650016, prebuf=288000, minreq=11520
[0x7fa6840011a0] main audio output debug: using audio output module
"pulse"
[0x7fa6840011a0] main audio output debug: TIMER module_need() : 10.977
ms - Total 10.977 ms / 1 intvls (Avg 10.977 ms)
[0x7fa6840011a0] main audio output debug: output 's16l' 48000 Hz 3F2M/
LFE frame=1 samples/12 bytes
[0x7fa6840011a0] main audio output debug: mixer 'f32l' 48000 Hz 3F2M/
LFE frame=1 samples/24 bytes
[0x7fa6840011a0] main audio output debug: filter(s) 'f32l'->'s16l'
48000 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x1eb9fd0] main audio filter debug: looking for audio filter module:
11 candidates
[0x1eb9fd0] audio_format audio filter debug: f32l->s16l, bits per
sample: 32->16
[0x1eb9fd0] main audio filter debug: using audio filter module
"audio_format"
[0x1eb9fd0] main audio filter debug: TIMER module_need() : 0.161 ms -
Total 0.161 ms / 1 intvls (Avg 0.161 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x2cdebb0] main generic debug: looking for audio mixer module: 3
candidates
[0x2cdebb0] main generic debug: using audio mixer module
"float32_mixer"
[0x2cdebb0] main generic debug: TIMER module_need() : 0.091 ms - Total
0.091 ms / 1 intvls (Avg 0.091 ms)
[0x7fa6840011a0] main audio output debug: input 's16l' 48000 Hz 3F2M/
LFE frame=1 samples/12 bytes
[0x2d15dd0] main audio filter debug: looking for audio filter module:
1 candidate
[0x2d15dd0] scaletempo audio filter debug: format: 48000 rate, 6 nch,
4 bps, fl32
[0x2d15dd0] scaletempo audio filter debug: params: 30 stride, 0.200
overlap, 14 search
[0x2d15dd0] scaletempo audio filter debug: 1.000 scale, 1440.000
stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search,
2400 queue, fl32 mode
[0x2d15dd0] main audio filter debug: using audio filter module
"scaletempo"
[0x2d15dd0] main audio filter debug: TIMER module_need() : 0.157 ms -
Total 0.157 ms / 1 intvls (Avg 0.157 ms)
[0x7fa6840011a0] main audio output debug: filter(s) 's16l'->'f32l'
48000 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x31a99a0] main audio filter debug: looking for audio filter module:
11 candidates
[0x31a99a0] audio_format audio filter debug: s16l->f32l, bits per
sample: 16->32
[0x31a99a0] main audio filter debug: using audio filter module
"audio_format"
[0x31a99a0] main audio filter debug: TIMER module_need() : 0.107 ms -
Total 0.107 ms / 1 intvls (Avg 0.107 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x7fa6840011a0] main audio output debug: filter(s) 'f32l'->'f32l'
52800 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x31a9d90] main audio filter debug: looking for audio filter module:
11 candidates
[0x31a9d90] main audio filter debug: using audio filter module
"ugly_resampler"
[0x31a9d90] main audio filter debug: TIMER module_need() : 0.084 ms -
Total 0.084 ms / 1 intvls (Avg 0.084 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x38a72b0] main decoder debug: End of audio preroll
[0x1fb7870] main input debug: Decoder buffering done in 8 ms
[0x2d2cf70] main video output debug: Post-processing available
[0x2d2cf70] main video output warning: vlc_object_find_name(postproc)
is not safe!
[0x7fa6840011a0] main audio output warning: PTS is out of range
(597400), dropping buffer
[0x7fa6840011a0] main audio output warning: PTS is out of range
(469487), dropping buffer
[0x7fa684001fb0] freetype spu text debug: using fontsize: 45
[0x7fa6840011a0] main audio output warning: PTS is out of range
(437960), dropping buffer
[0x2d2a410] main blend debug: looking for video blending module: 1
candidate
[0x2d2a410] blend blend debug: chroma: YUVA -> I420
[0x2d2a410] main blend debug: using video blending module "blend"
[0x7fa6840011a0] main audio output warning: PTS is out of range
(217037), dropping buffer
[0x2d2a410] main blend debug: TIMER module_need() : 0.157 ms - Total
0.157 ms / 1 intvls (Avg 0.157 ms)
[0x7fa6840011a0] main audio output warning: PTS is out of range
(185506), dropping buffer
[0x7fa6840011a0] main audio output warning: PTS is out of range
(154189), dropping buffer
[0x7fa6840011a0] pulse audio output debug: uncorking
[0x7fa6840011a0] pulse audio output debug: started
[0x2d2cf70] main video output warning: late picture skipped (48615 >
-26277)
[0x2d2cf70] main video output warning: late picture skipped (-1792 >
-6049)
[0x2d01270] xcb_window window debug: key: 0x00000000
[0x2d01270] xcb_window window debug: key: 0x00000073
[0x2d2cf70] main video output error: Encoding support not compiled-in!
[0x2d2cf70] main video output error: Failed to convert image for
snapshot
[0x2d01270] xcb_window window debug: key: 0x0000006f
[0x2d00da0] main generic warning: VoutDisplayEvent 'pictures invalid'
[0x2d00da0] main generic debug: Filter 0x2d05ab0 removed from chain
[0x2d05ab0] main filter debug: removing module "swscale"
[0x2d00da0] main generic debug: A filter to adapt decoder to display
is needed
[0x7fa68423dd10] main filter debug: looking for video filter2 module:
18 candidates
[0x7fa68423dd10] swscale filter debug: 1280x720 chroma: I420 ->
1280x720 chroma: RV32 with scaling using Bicubic (good quality)
[0x7fa68423dd10] main filter debug: using video filter2 module
"swscale"
[0x7fa68423dd10] main filter debug: TIMER module_need() : 0.192 ms -
Total 0.192 ms / 1 intvls (Avg 0.192 ms)
[0x2d00da0] main generic debug: Filter 'Swscale' (0x7fa68423dd10)
appended to chain
[0x7fa684001fb0] freetype spu text debug: using fontsize: 45
[0x2d01270] xcb_window window debug: key: 0x00000072
[0x2d01270] xcb_window window debug: key: 0x00000072
[0x2d00da0] main generic debug: auto hidding mouse
[0x2d01270] xcb_window window debug: key: 0x00000000
[0x2d2cf70] main video output warning: late picture skipped (41012 >
-2645)
[0x2d2cf70] main video output warning: late picture skipped (24323 >
-2645)
[0x2d2cf70] main video output warning: late picture skipped (19004 >
-2958)
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (1758
bytes)
ac-tex damaged at 25 13
invalid mb type in B Frame at 0 0
ac-tex damaged at 0 2
qscale == 0
ac-tex damaged at 10 14
invalid mb type in B Frame at 4 28
ac-tex damaged at 1 32
slice mismatch
ac-tex damaged at 10 34
invalid cbp at 75 35
invalid mb type in B Frame at 32 36
ac-tex damaged at 23 37
ac-tex damaged at 21 38
ac-tex damaged at 39 39
ac-tex damaged at 16 40
ac-tex damaged at 50 41
ac-tex damaged at 10 42
ac-tex damaged at 30 43
end mismatch left=1398 380000
Warning MVs not available
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (688
bytes)
[0x7fa6840011a0] main audio output warning: buffer is 64000 in
advance, triggering downsampling
invalid cbp at 14 5
Warning MVs not available
ignoring pic cod ext after 0
[0x2d2cf70] main video output error: picture to display 0x2d2f410 has
invalid status 2
[0x7fa6840011a0] main audio output warning: resampling stopped after
14495966 usec (drift: -500)
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (504
bytes)
[0x7fa6840011a0] main audio output warning: buffer is 63500 in
advance, triggering downsampling
ac-tex damaged at 37 5
invalid mb type in B Frame at 3 4
ac-tex damaged at 7 44
Warning MVs not available
[0x7fa6840011a0] main audio output warning: resampling stopped after
14432013 usec (drift: -416)
[0x2d2cf70] main video output warning: late picture skipped (12790 >
-2318)
I'm really enjoying mythdroid after having just found it. Great work!
I'm having trouble streaming recordings to the phone. My setup has a
(slow) master backend and a (fast) slave backend. I'm trying to
stream from the slave backend to the phone. Everything else (remote
related) seems to work. However, on pushing "Here" for a recording, I
get the "Sorry, this video cannot be played" error on the phone and
the video displays on the backend screen. The display looks fine. (It
is not playing on the frontend instance, just displayed on screen).
All this on gentoo boxes with mythtv-0.24.1, mdd and mythdroid 0.5.1,
on an Inspire
Below is my /tmp/vlc.out and files. I've clipped them just a bit but
the relevant stuff should be there.
cat /tmp/mdd.log
Tue 13 Sep 23:35:02 - Warning - VLC: frame sync error
Tue 13 Sep 23:35:02 - Warning - VLC: [0x7f0174002530] main video
output error: picture to display 0x7f0174002ae0 has invalid status 2
Tue 13 Sep 23:35:02 - Warning - VLC: [0x7f0174002530] main video
output error: picture to display 0x7f0174002ae0 has invalid status 2
Tue 13 Sep 23:35:19 - Warning - VLC: frame sync error
Tue 13 Sep 23:38:07 - Warning - VLC: [0x2d2cf70] main video output
error: Encoding support not compiled-in!
Tue 13 Sep 23:38:07 - Warning - VLC: [0x2d2cf70] main video output
error: Failed to convert image for snapshot
Tue 13 Sep 23:39:04 - Warning - VLC: frame sync error
Tue 13 Sep 23:39:09 - Warning - VLC: frame sync error
Tue 13 Sep 23:39:10 - Warning - VLC: [0x2d2cf70] main video output
error: picture to display 0x2d2f410 has invalid status 2
Tue 13 Sep 23:39:24 - Warning - VLC: frame sync error
cat /tmp/vlc.out
VLC media player 1.1.11 The Luggage (revision exported)
[0x1d9e120] main libvlc debug: VLC media player - 1.1.11 The Luggage
[0x1d9e120] main libvlc debug: Copyright © 1996-2011 the VideoLAN team
[0x1d9e120] main libvlc debug: revision exported
[0x1d9e120] main libvlc debug: configured with ./configure '--prefix=/
usr' '--build=x86_64-pc-linux-gnu' '--host=x86_64-pc-linux-gnu' '--
mandir=/usr/share/man' '--infodir=/usr/share/info' '--datadir=/usr/
share' '--sysconfdir=/etc' '--localstatedir=/var/lib' '--libdir=/usr/
lib64' '--disable-a52' '--disable-aa' '--enable-faad' '--enable-alsa'
'--disable-altivec' '--disable-asademux' '--disable-atmo' '--disable-
bonjour' '--disable-fribidi' '--disable-vcd' '--disable-libcddb' '--
enable-dbus' '--enable-dbus-control' '--disable-dirac' '--disable-
directfb' '--disable-dc1394' '--disable-debug' '--disable-dca' '--
disable-dvb' '--enable-dvdread' '--enable-dvdnav' '--disable-fb' '--
enable-avcodec' '--enable-avformat' '--enable-swscale' '--enable-
postproc' '--enable-flac' '--disable-fluidsynth' '--disable-
fontconfig' '--disable-ggi' '--disable-gme' '--disable-gnomevfs' '--
disable-gnutls' '--disable-httpd' '--disable-id3tag' '--disable-dv' '--
disable-jack' '--disable-kate' '--with-kde-solid' '--disable-libass'
'--disable-caca' '--enable-libgcrypt' '--disable-notify' '--disable-
libproxy' '--disable-libtar' '--disable-tiger' '--disable-libv4l' '--
disable-libv4l2' '--disable-lirc' '--disable-live555' '--disable-lua'
'--disable-mkv' '--enable-mmx' '--disable-mod' '--enable-mad' '--
enable-libmpeg2' '--disable-mtp' '--disable-mpc' '--enable-ncurses' '--
enable-mozilla' '--with-mozilla-pkg=libxul' '--enable-ogg' '--enable-
glx' '--enable-opengl' '--disable-optimize-memory' '--disable-oss' '--
enable-png' '--disable-portaudio' '--disable-projectm' '--enable-
pulse' '--disable-pvr' '--enable-qt4' '--disable-remoteosd' '--disable-
realrtsp' '--disable-run-as-root' '--disable-smb' '--disable-
schroedinger' '--enable-sdl' '--disable-sdl-image' '--disable-shine'
'--disable-shout' '--disable-skins2' '--disable-speex' '--disable-
sqlite' '--enable-sse' '--disable-sout' '--enable-svg' '--disable-
svgalib' '--disable-taglib' '--disable-theora' '--enable-freetype' '--
disable-twolame' '--disable-udev' '--disable-upnp' '--enable-v4l' '--
disable-v4l2' '--disable-vcdx' '--disable-libva' '--disable-vlm' '--
enable-vorbis' '--disable-loader' '--disable-wma-fixed' '--enable-
x264' '--enable-libxml2' '--disable-xosd' '--disable-xvideo' '--
disable-zvbi' '--enable-telx' '--disable-snapshot' '--disable-growl'
'--disable-optimizations' '--enable-fast-install' '--enable-xcb' '--
with-x' 'build_alias=x86_64-pc-linux-gnu' 'host_alias=x86_64-pc-linux-
gnu' 'CFLAGS=-march=native -O2 -pipe' 'LDFLAGS=' 'CXXFLAGS=-
march=native -O2 -pipe' 'PKG_CONFIG_PATH=/usr/lib64/pkgconfig'
[0x1d9e120] main libvlc debug: translation test: code is "C"
[0x1d9e120] main libvlc debug: checking plugin modules
[0x1d9e120] main libvlc debug: loading plugins cache file /usr/lib64/
vlc/plugins/plugins-04081e-fe8.dat
[0x1d9e120] main libvlc debug: recursively browsing `/usr/lib64/vlc/
plugins'
[0x1d9e120] main libvlc debug: saving plugins cache /usr/lib64/vlc/
plugins/plugins-04081e-fe8.dat
[0x1d9e120] main libvlc debug: module bank initialized (291 modules)
[0x1d9e120] main libvlc debug: opening config file (/home/pete/.config/
vlc/vlcrc)
[0x1d9e120] main libvlc debug: CPU has capabilities MMX MMXEXT SSE
SSE2 SSE3 SSSE3 SSE4.1 SSE4.2 FPU
[0x1d9e120] main libvlc debug: looking for memcpy module: 3 candidates
[0x1d9e120] main libvlc debug: using memcpy module "memcpymmxext"
[0x1e467f0] main input debug: Creating an input for 'Media Library'
[0x1e467f0] main input debug: Input is a meta file: disabling unneeded
options
[0x1e467f0] main input debug: using timeshift granularity of 50 MiB
[0x1e467f0] main input debug: using timeshift path '/tmp'
[0x1e467f0] main input debug: `file/xspf-open:///home/pete/.local/
share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/
pete/.local/share/vlc/ml.xspf'
[0x1e467f0] main input debug: creating demux: access='file'
demux='xspf-open' path='/home/pete/.local/share/vlc/ml.xspf'
[0x1fb7c70] main demux debug: looking for access_demux module: 2
candidates
[0x1fb7c70] main demux debug: no access_demux module matching "file"
could be loaded
[0x1fb7c70] main demux debug: TIMER module_need() : 0.142 ms - Total
0.142 ms / 1 intvls (Avg 0.142 ms)
[0x1e467f0] main input debug: creating access 'file' path='/home/
pete/.local/share/vlc/ml.xspf'
[0x1fb80f0] main access debug: looking for access module: 2 candidates
[0x1fb80f0] filesystem access debug: opening file `/home/pete/.local/
share/vlc/ml.xspf'
[0x1fb80f0] main access debug: using access module "filesystem"
[0x1fb80f0] main access debug: TIMER module_need() : 0.136 ms - Total
0.136 ms / 1 intvls (Avg 0.136 ms)
[0x1fb8480] main stream debug: Using AStream*Stream
[0x1fb8480] main stream debug: pre buffering
[0x1fb8480] main stream debug: received first data after 0 ms
[0x1fb8480] main stream debug: pre-buffering done 296 bytes in 0s -
26278 KiB/s
[0x1fb86f0] main stream debug: looking for stream_filter module: 5
candidates
[0x1fb86f0] main stream debug: no stream_filter module matching "any"
could be loaded
[0x1fb86f0] main stream debug: TIMER module_need() : 0.085 ms - Total
0.085 ms / 1 intvls (Avg 0.085 ms)
[0x1fb86f0] main stream debug: looking for stream_filter module: 1
candidate
[0x1fb86f0] main stream debug: using stream_filter module
"stream_filter_record"
[0x1fb86f0] main stream debug: TIMER module_need() : 0.079 ms - Total
0.079 ms / 1 intvls (Avg 0.079 ms)
[0x1e467f0] main input debug: creating demux: access='file'
demux='xspf-open' path='/home/pete/.local/share/vlc/ml.xspf'
[0x1fb89f0] main demux debug: looking for demux module: 1 candidate
[0x1fb89f0] playlist demux debug: using XSPF playlist reader
[0x1fb89f0] main demux debug: using demux module "playlist"
[0x1fb89f0] main demux debug: TIMER module_need() : 0.100 ms - Total
0.100 ms / 1 intvls (Avg 0.100 ms)
[0x1fb8dc0] main demux meta debug: looking for meta reader module: 0
candidates
[0x1fb8dc0] main demux meta debug: no meta reader module matched "any"
[0x1fb8dc0] main demux meta debug: TIMER module_need() : 0.064 ms -
Total 0.064 ms / 1 intvls (Avg 0.064 ms)
[0x1e467f0] main input debug: `file/xspf-open:///home/pete/.local/
share/vlc/ml.xspf' successfully opened
[0x1fb8d10] main xml debug: looking for xml module: 2 candidates
[0x1fb8d10] main xml debug: using xml module "xml"
[0x1fb8d10] main xml debug: TIMER module_need() : 0.138 ms - Total
0.138 ms / 1 intvls (Avg 0.138 ms)
[0x1fb89f0] playlist demux debug: parsed 0 tracks successfully
[0x1fb8d10] main xml debug: removing module "xml"
[0x1e467f0] main input debug: EOF reached
[0x1fb89f0] main demux debug: removing module "playlist"
[0x1fb86f0] main stream debug: removing module "stream_filter_record"
[0x1fb80f0] main access debug: removing module "filesystem"
[0x1e467f0] main input debug: TIMER input launching for 'Media
Library' : 1.471 ms - Total 1.471 ms / 1 intvls (Avg 1.471 ms)
[0x1e469d0] main interface debug: looking for interface module: 1
candidate
[0x1e469d0] main interface debug: using interface module "hotkeys"
[0x1e469d0] main interface debug: TIMER module_need() : 0.091 ms -
Total 0.091 ms / 1 intvls (Avg 0.091 ms)
[0x1e47d10] main interface debug: looking for interface module: 1
candidate
Blocked: call to unsetenv("DBUS_ACTIVATION_ADDRESS")
Blocked: call to unsetenv("DBUS_ACTIVATION_BUS_TYPE")
[0x1db0310] main playlist debug: Activated
[0x1e47d10] main interface debug: using interface module "inhibit"
[0x1e47d10] main interface debug: TIMER module_need() : 1.003 ms -
Total 1.003 ms / 1 intvls (Avg 1.003 ms)
[0x1db0310] main playlist debug: adding item
`2171_20110913010000.mpg' ( file:///home/mythtv//2171_20110913010000.mpg
)
[0x1db0310] main playlist debug: rebuilding array of current - root
Playlist
[0x1db0310] main playlist debug: rebuild done - 0 items, index -1
[0x1e48b60] main input debug: Creating an input for
'2171_20110913010000.mpg'
[0x1fb6ee0] main interface debug: looking for interface module: 1
candidate
[0x1fb6ee0] main interface debug: using interface module "signals"
[0x1fb6ee0] main interface debug: TIMER module_need() : 0.124 ms -
Total 0.124 ms / 1 intvls (Avg 0.124 ms)
[0x1e48640] main interface debug: looking for interface module: 1
candidate
[0x1e48640] main interface debug: using interface module
"globalhotkeys"
[0x1e48640] main interface debug: TIMER module_need() : 0.433 ms -
Total 0.433 ms / 1 intvls (Avg 0.433 ms)
[0x1e48dc0] main interface debug: looking for interface module: 1
candidate
[0x1e48dc0] oldrc interface debug: base: 0.0.0.0, port: 16547
[0x1e48dc0] main interface debug: net: listening to 0.0.0.0 port 16547
Remote control interface initialized. Type `help' for help.
[0x1e48dc0] main interface debug: using interface module "oldrc"
[0x1e48dc0] main interface debug: TIMER module_need() : 0.190 ms -
Total 0.190 ms / 1 intvls (Avg 0.190 ms)
[0x1e48dc0] main interface debug: thread (interface) created at
priority 0 (interface/interface.c:164)
[0x1e48dc0] main interface debug: thread started
[0x1db0310] main playlist debug: processing request item null node
Playlist skip 0
[0x1db0310] main playlist debug: rebuilding array of current - root
Playlist
[0x1db0310] main playlist debug: rebuild done - 1 items, index -1
[0x1db0310] main playlist debug: starting new item
[0x1db0310] main playlist debug: creating new input thread
[0x1fb7870] main input debug: Creating an input for
'2171_20110913010000.mpg'
[0x1fb7870] main input debug: thread (input) created at priority 10
(input/input.c:220)
[0x1fb7870] main input debug: thread started
[0x1fb7870] main input debug: using timeshift granularity of 50 MiB
[0x1fb7870] main input debug: using timeshift path '/tmp'
[0x1fb7870] main input debug: `file:///home/mythtv//
2171_20110913010000.mpg' gives access `file' demux `' path `/home/
mythtv//2171_20110913010000.mpg'
[0x1fb7870] main input debug: enforced demux ` avformat'
[0x1fb7870] main input debug: creating demux: access='file'
demux='avformat' path='/home/mythtv//2171_20110913010000.mpg'
[0x2088920] main demux debug: looking for access_demux module: 2
candidates
[0x2088920] main demux debug: no access_demux module matching "file"
could be loaded
[0x2088920] main demux debug: TIMER module_need() : 7.612 ms - Total
7.612 ms / 1 intvls (Avg 7.612 ms)
[0x1fb7870] main input debug: creating access 'file' path='/home/
mythtv//2171_20110913010000.mpg'
[0x2088fd0] main access debug: looking for access module: 2 candidates
[0x2088fd0] filesystem access debug: opening file `/home/mythtv//
2171_20110913010000.mpg'
[0x2088fd0] main access debug: using access module "filesystem"
[0x2088fd0] main access debug: TIMER module_need() : 1.523 ms - Total
1.523 ms / 1 intvls (Avg 1.523 ms)
[0x20893d0] main stream debug: Using AStream*Stream
[0x20893d0] main stream debug: pre buffering
[0x20893d0] main stream debug: received first data after 14 ms
[0x20893d0] main stream debug: pre-buffering done 1024 bytes in 0s -
67 KiB/s
[0x7fa6840072f0] main stream debug: looking for stream_filter module:
5 candidates
[0x7fa6840072f0] main stream debug: no stream_filter module matching
"any" could be loaded
[0x7fa6840072f0] main stream debug: TIMER module_need() : 0.165 ms -
Total 0.165 ms / 1 intvls (Avg 0.165 ms)
[0x1fbacd0] main stream debug: looking for stream_filter module: 1
candidate
[0x1fbacd0] main stream debug: using stream_filter module
"stream_filter_record"
[0x1fbacd0] main stream debug: TIMER module_need() : 0.087 ms - Total
0.087 ms / 1 intvls (Avg 0.087 ms)
[0x1fb7870] main input debug: creating demux: access='file'
demux='avformat' path='/home/mythtv//2171_20110913010000.mpg'
[0x1fbafe0] main demux debug: looking for demux module: 1 candidate
[0x1fbafe0] avformat demux debug: detected format: mpegts
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpeg2video @ 0x38897e0] mpeg_decode_postinit() failure
[mpegts @ 0x3893130] max_analyze_duration 5000000 reached at 5003333
[0x1e48dc0] main interface debug: accepted socket 10 (from socket 6)
[0x1fb7870] main input debug: selecting program id=0
[0x1fbafe0] avformat demux debug: adding es: video codec = mpgv
[0x1fbafe0] avformat demux debug: adding es: audio codec = a52
[0x1fbafe0] avformat demux debug: adding es: audio codec = a52
[0x1fbafe0] avformat demux debug: AVFormat supported stream
[0x1fbafe0] avformat demux debug: - format = mpegts (MPEG-2
transport stream format)
[0x1fbafe0] avformat demux debug: - start time = 61546227389
[0x1fbafe0] avformat demux debug: - duration = 1826363123
[0x1fbafe0] main demux debug: using demux module "avformat"
[0x1fbafe0] main demux debug: TIMER module_need() : 4262.916 ms -
Total 4262.916 ms / 1 intvls (Avg 4262.916 ms)
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[0x1fb7870] main input debug: looking for a subtitle file in /home/
mythtv//
[mpeg2video @ 0x7fa684026310] mpeg_decode_postinit() failure
[0x3889f90] main decoder debug: looking for decoder module: 25
candidates
[mpegts @ 0x7fa6840107c0] max_analyze_duration 5000000 reached at
5003333
[0x3889f90] avcodec decoder debug: libavcodec initialized (interface
0x347a00)
[0x1db0310] main playlist debug: no fetch required for (null) (art
currently (null))
[0x3889f90] avcodec decoder debug: trying to use direct rendering
[0x3889f90] avcodec decoder debug: ffmpeg codec (MPEG-1/2 Video)
started
[0x3889f90] main decoder debug: using decoder module "avcodec"
[0x3889f90] main decoder debug: TIMER module_need() : 43.483 ms -
Total 43.483 ms / 1 intvls (Avg 43.483 ms)
[0x3889f90] main decoder debug: thread (decoder) created at priority 0
(input/decoder.c:301)
[0x3889f90] main decoder debug: thread started
[0x38a72b0] main decoder debug: looking for decoder module: 25
candidates
[0x38a72b0] avcodec decoder debug: libavcodec already initialized
[0x38a72b0] avcodec decoder debug: ffmpeg codec (A52 Audio (aka AC3))
started
[0x38a72b0] avcodec decoder debug: Using 192000 bytes output buffer
[0x38a72b0] main decoder debug: using decoder module "avcodec"
[0x38a72b0] main decoder debug: TIMER module_need() : 1.667 ms - Total
1.667 ms / 1 intvls (Avg 1.667 ms)
[0x38a72b0] main decoder debug: thread (decoder) created at priority 5
(input/decoder.c:301)
[0x38a72b0] main decoder debug: thread started
[0x38a8500] main demux meta debug: looking for meta reader module: 0
candidates
[0x38a8500] main demux meta debug: no meta reader module matched "any"
[0x38a8500] main demux meta debug: TIMER module_need() : 0.072 ms -
Total 0.072 ms / 1 intvls (Avg 0.072 ms)
[0x1fb7870] main input debug: `file:///home/mythtv//
2171_20110913010000.mpg' successfully opened
[0x1fb7870] main input debug: Buffering 0%
[0x1fb7870] main input debug: Buffering 0%
[0x1fb7870] main input debug: no usable vout present, spawning one
[0x1fb7870] main input debug: Buffering 1%
[0x7fa684001fb0] main spu text debug: looking for text renderer
module: 3 candidates
[0x1fb7870] main input debug: Buffering 1%
[0x1fb7870] main input debug: Buffering 2%
[0x7fa684001fb0] freetype spu text debug: using fontsize: 2
[0x7fa684001fb0] main spu text debug: using text renderer module
"freetype"
[0x7fa684001fb0] main spu text debug: TIMER module_need() : 0.392 ms -
Total 0.392 ms / 1 intvls (Avg 0.392 ms)
[0x2d36f30] main scale debug: looking for video filter2 module: 18
candidates
[0x1fb7870] main input debug: Buffering 2%
[0x1fb7870] main input debug: Buffering 3%
[0x2d36f30] swscale scale debug: 32x32 chroma: YUVA -> 16x16 chroma:
YUVA with scaling using Bicubic (good quality)
[0x2d36f30] main scale debug: using video filter2 module "swscale"
[0x1fb7870] main input debug: Buffering 4%
[0x2d36f30] main scale debug: TIMER module_need() : 0.440 ms - Total
0.440 ms / 1 intvls (Avg 0.440 ms)
[0x2d41a00] main scale debug: looking for video filter2 module: 18
candidates
[0x2d41a00] yuvp scale debug: YUVP to YUVA converter
[0x2d41a00] main scale debug: using video filter2 module "yuvp"
[0x2d41a00] main scale debug: TIMER module_need() : 0.106 ms - Total
0.106 ms / 1 intvls (Avg 0.106 ms)
[0x2d2cf70] main video output debug: window size: 1280x720
[0x2d2cf70] main video output debug: Deinterlacing available
[0x2d2cf70] main video output debug: deinterlace 0, mode blend,
is_needed 0
[0x2d2cf70] main video output debug: looking for video output module:
1 candidate
[0x2d2cf70] vout_wrapper video output debug: Opening vout display
wrapper
[0x2d00da0] main generic debug: looking for vout display module: 4
candidates
[0x1fb7870] main input debug: Buffering 4%
[0x2d01270] main window debug: looking for vout window xid module: 3
candidates
[0x2d01270] qt4 window debug: Qt4 interface not found
[0x1fb7870] main input debug: Buffering 5%
[0x1fb7870] main input debug: Buffering 6%
[0x2d01270] main window debug: using vout window xid module
"xcb_window"
[0x2d01270] main window debug: TIMER module_need() : 0.783 ms - Total
0.783 ms / 1 intvls (Avg 0.783 ms)
[0x2d04bc0] main inhibit debug: looking for inhibit module: 2
candidates
[0x2d04bc0] main inhibit debug: using inhibit module "xdg_screensaver"
[0x2d04bc0] main inhibit debug: TIMER module_need() : 0.099 ms - Total
0.099 ms / 1 intvls (Avg 0.099 ms)
[0x2d04bc0] xdg_screensaver inhibit debug: started xdg-screensaver
(PID = 7565)
[0x1fb7870] main input debug: Buffering 7%
[0x1fb7870] main input debug: Buffering 52%
[0x2d00da0] xcb_x11 generic debug: connected to X11.0 server
[0x2d00da0] xcb_x11 generic debug: vendor : The X.Org Foundation
[0x2d00da0] xcb_x11 generic debug: version: 11004000
[0x1fb7870] main input debug: Buffering 52%
[0x1fb7870] main input debug: Buffering 53%
[0x2d00da0] xcb_x11 generic debug: using screen 0x15a
[0x2d00da0] xcb_x11 generic debug: X11 visual with alpha-channel not
supported
[0x2d00da0] xcb_x11 generic debug: using X11 visual ID 0x21
[0x2d00da0] xcb_x11 generic debug: 24 bits depth
[0x2d00da0] xcb_x11 generic debug: 32 bits per pixel
[0x2d00da0] xcb_x11 generic debug: 32 bits line pad
[0x1fb7870] main input debug: Buffering 54%
[0x1fb7870] main input debug: Buffering 54%
[0x1fb7870] main input debug: Buffering 55%
[0x1fb7870] main input debug: Buffering 55%
[0x1fb7870] main input debug: Buffering 56%
[0x2d00da0] xcb_x11 generic debug: using X11 window 06a00000
[0x2d00da0] xcb_x11 generic debug: using X11 graphic context 06a00001
[0x1fb7870] main input debug: Buffering 56%
[0x1fb7870] main input debug: Buffering 57%
[0x2d00da0] main generic debug: VoutDisplayEvent 'fullscreen' 0
[0x2d00da0] main generic debug: VoutDisplayEvent 'resize' 1280x720
window
[0x2d00da0] main generic debug: using vout display module "xcb_x11"
[0x2d00da0] main generic debug: TIMER module_need() : 14.409 ms -
Total 14.409 ms / 1 intvls (Avg 14.409 ms)
[0x2d00da0] main generic debug: A filter to adapt decoder to display
is needed
[0x1fb7870] main input debug: Buffering 58%
[0x1fb7870] main input debug: Buffering 58%
[0x2d05ab0] main filter debug: looking for video filter2 module: 18
candidates
[0x1fb7870] main input debug: Buffering 59%
[0x2d05ab0] swscale filter debug: 1280x720 chroma: I420 -> 1280x720
chroma: RV32 with scaling using Bicubic (good quality)
[0x2d05ab0] main filter debug: using video filter2 module "swscale"
[0x2d05ab0] main filter debug: TIMER module_need() : 0.235 ms - Total
0.235 ms / 1 intvls (Avg 0.235 ms)
[0x2d00da0] main generic debug: Filter 'Swscale' (0x2d05ab0) appended
to chain
[0x2d2cf70] main video output debug: using video output module
"vout_wrapper"
[0x2d2cf70] main video output debug: TIMER module_need() : 14.885 ms -
Total 14.885 ms / 1 intvls (Avg 14.885 ms)
[0x1fb7870] main input debug: Buffering 59%
[0x2d2cf70] main video output debug: got 1 direct buffer(s)
[0x2d2cf70] main video output debug: pic render sz 1280x720, of (0,0),
vsz 1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x2d2cf70] main video output debug: pic in sz 1280x720, of (0,0), vsz
1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x1fb7870] main input debug: Buffering 60%
[0x2d2cf70] main video output debug: pic out sz 1280x720, of (0,0),
vsz 1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[0x2d2cf70] main video output debug: direct render, mapping render
pictures 0-23 to system pictures 1-24
[0x1fb7870] main input debug: Buffering 60%
[0x3889f90] avcodec decoder debug: using direct rendering
warning: first frame is no keyframe
[0x1fb7870] main input debug: creating aout
[0x7fa6840011a0] main audio output debug: looking for audio output
module: 4 candidates
[0x7fa6840011a0] pulse audio output debug: using ? channel map
[0x1fb7870] main input debug: Buffering 61%
[0x1fb7870] main input debug: Buffering 79%
[0x3889f90] main decoder debug: End of video preroll
[0x3889f90] main decoder debug: Received first picture
[0x2d00da0] xcb_x11 generic debug: display is visible
[0x1fb7870] main input debug: Buffering 80%
[0x1fb7870] main input debug: Buffering 99%
[0x1fb7870] main input debug: Stream buffering done (2902 ms in 27 ms)
[0x7fa6840011a0] pulse audio output debug: connected to device
alsa_output.pci-0000_01_00.0.analog-stereo (0)
[0x7fa6840011a0] pulse audio output debug: using buffer metrics:
maxlength=4194312, tlength=650016, prebuf=288000, minreq=11520
[0x7fa6840011a0] main audio output debug: using audio output module
"pulse"
[0x7fa6840011a0] main audio output debug: TIMER module_need() : 10.977
ms - Total 10.977 ms / 1 intvls (Avg 10.977 ms)
[0x7fa6840011a0] main audio output debug: output 's16l' 48000 Hz 3F2M/
LFE frame=1 samples/12 bytes
[0x7fa6840011a0] main audio output debug: mixer 'f32l' 48000 Hz 3F2M/
LFE frame=1 samples/24 bytes
[0x7fa6840011a0] main audio output debug: filter(s) 'f32l'->'s16l'
48000 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x1eb9fd0] main audio filter debug: looking for audio filter module:
11 candidates
[0x1eb9fd0] audio_format audio filter debug: f32l->s16l, bits per
sample: 32->16
[0x1eb9fd0] main audio filter debug: using audio filter module
"audio_format"
[0x1eb9fd0] main audio filter debug: TIMER module_need() : 0.161 ms -
Total 0.161 ms / 1 intvls (Avg 0.161 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x2cdebb0] main generic debug: looking for audio mixer module: 3
candidates
[0x2cdebb0] main generic debug: using audio mixer module
"float32_mixer"
[0x2cdebb0] main generic debug: TIMER module_need() : 0.091 ms - Total
0.091 ms / 1 intvls (Avg 0.091 ms)
[0x7fa6840011a0] main audio output debug: input 's16l' 48000 Hz 3F2M/
LFE frame=1 samples/12 bytes
[0x2d15dd0] main audio filter debug: looking for audio filter module:
1 candidate
[0x2d15dd0] scaletempo audio filter debug: format: 48000 rate, 6 nch,
4 bps, fl32
[0x2d15dd0] scaletempo audio filter debug: params: 30 stride, 0.200
overlap, 14 search
[0x2d15dd0] scaletempo audio filter debug: 1.000 scale, 1440.000
stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search,
2400 queue, fl32 mode
[0x2d15dd0] main audio filter debug: using audio filter module
"scaletempo"
[0x2d15dd0] main audio filter debug: TIMER module_need() : 0.157 ms -
Total 0.157 ms / 1 intvls (Avg 0.157 ms)
[0x7fa6840011a0] main audio output debug: filter(s) 's16l'->'f32l'
48000 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x31a99a0] main audio filter debug: looking for audio filter module:
11 candidates
[0x31a99a0] audio_format audio filter debug: s16l->f32l, bits per
sample: 16->32
[0x31a99a0] main audio filter debug: using audio filter module
"audio_format"
[0x31a99a0] main audio filter debug: TIMER module_need() : 0.107 ms -
Total 0.107 ms / 1 intvls (Avg 0.107 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x7fa6840011a0] main audio output debug: filter(s) 'f32l'->'f32l'
52800 Hz->48000 Hz 3F2M/LFE->3F2M/LFE
[0x31a9d90] main audio filter debug: looking for audio filter module:
11 candidates
[0x31a9d90] main audio filter debug: using audio filter module
"ugly_resampler"
[0x31a9d90] main audio filter debug: TIMER module_need() : 0.084 ms -
Total 0.084 ms / 1 intvls (Avg 0.084 ms)
[0x7fa6840011a0] main audio output debug: found a filter for the whole
conversion
[0x38a72b0] main decoder debug: End of audio preroll
[0x1fb7870] main input debug: Decoder buffering done in 8 ms
[0x2d2cf70] main video output debug: Post-processing available
[0x2d2cf70] main video output warning: vlc_object_find_name(postproc)
is not safe!
[0x7fa6840011a0] main audio output warning: PTS is out of range
(597400), dropping buffer
[0x7fa6840011a0] main audio output warning: PTS is out of range
(469487), dropping buffer
[0x7fa684001fb0] freetype spu text debug: using fontsize: 45
[0x7fa6840011a0] main audio output warning: PTS is out of range
(437960), dropping buffer
[0x2d2a410] main blend debug: looking for video blending module: 1
candidate
[0x2d2a410] blend blend debug: chroma: YUVA -> I420
[0x2d2a410] main blend debug: using video blending module "blend"
[0x7fa6840011a0] main audio output warning: PTS is out of range
(217037), dropping buffer
[0x2d2a410] main blend debug: TIMER module_need() : 0.157 ms - Total
0.157 ms / 1 intvls (Avg 0.157 ms)
[0x7fa6840011a0] main audio output warning: PTS is out of range
(185506), dropping buffer
[0x7fa6840011a0] main audio output warning: PTS is out of range
(154189), dropping buffer
[0x7fa6840011a0] pulse audio output debug: uncorking
[0x7fa6840011a0] pulse audio output debug: started
[0x2d2cf70] main video output warning: late picture skipped (48615 >
-26277)
[0x2d2cf70] main video output warning: late picture skipped (-1792 >
-6049)
[0x2d01270] xcb_window window debug: key: 0x00000000
[0x2d01270] xcb_window window debug: key: 0x00000073
[0x2d2cf70] main video output error: Encoding support not compiled-in!
[0x2d2cf70] main video output error: Failed to convert image for
snapshot
[0x2d01270] xcb_window window debug: key: 0x0000006f
[0x2d00da0] main generic warning: VoutDisplayEvent 'pictures invalid'
[0x2d00da0] main generic debug: Filter 0x2d05ab0 removed from chain
[0x2d05ab0] main filter debug: removing module "swscale"
[0x2d00da0] main generic debug: A filter to adapt decoder to display
is needed
[0x7fa68423dd10] main filter debug: looking for video filter2 module:
18 candidates
[0x7fa68423dd10] swscale filter debug: 1280x720 chroma: I420 ->
1280x720 chroma: RV32 with scaling using Bicubic (good quality)
[0x7fa68423dd10] main filter debug: using video filter2 module
"swscale"
[0x7fa68423dd10] main filter debug: TIMER module_need() : 0.192 ms -
Total 0.192 ms / 1 intvls (Avg 0.192 ms)
[0x2d00da0] main generic debug: Filter 'Swscale' (0x7fa68423dd10)
appended to chain
[0x7fa684001fb0] freetype spu text debug: using fontsize: 45
[0x2d01270] xcb_window window debug: key: 0x00000072
[0x2d01270] xcb_window window debug: key: 0x00000072
[0x2d00da0] main generic debug: auto hidding mouse
[0x2d01270] xcb_window window debug: key: 0x00000000
[0x2d2cf70] main video output warning: late picture skipped (41012 >
-2645)
[0x2d2cf70] main video output warning: late picture skipped (24323 >
-2645)
[0x2d2cf70] main video output warning: late picture skipped (19004 >
-2958)
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (1758
bytes)
ac-tex damaged at 25 13
invalid mb type in B Frame at 0 0
ac-tex damaged at 0 2
qscale == 0
ac-tex damaged at 10 14
invalid mb type in B Frame at 4 28
ac-tex damaged at 1 32
slice mismatch
ac-tex damaged at 10 34
invalid cbp at 75 35
invalid mb type in B Frame at 32 36
ac-tex damaged at 23 37
ac-tex damaged at 21 38
ac-tex damaged at 39 39
ac-tex damaged at 16 40
ac-tex damaged at 50 41
ac-tex damaged at 10 42
ac-tex damaged at 30 43
end mismatch left=1398 380000
Warning MVs not available
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (688
bytes)
[0x7fa6840011a0] main audio output warning: buffer is 64000 in
advance, triggering downsampling
invalid cbp at 14 5
Warning MVs not available
ignoring pic cod ext after 0
[0x2d2cf70] main video output error: picture to display 0x2d2f410 has
invalid status 2
[0x7fa6840011a0] main audio output warning: resampling stopped after
14495966 usec (drift: -500)
frame CRC mismatch
frame sync error
[0x38a72b0] avcodec decoder warning: cannot decode one frame (504
bytes)
[0x7fa6840011a0] main audio output warning: buffer is 63500 in
advance, triggering downsampling
ac-tex damaged at 37 5
invalid mb type in B Frame at 3 4
ac-tex damaged at 7 44
Warning MVs not available
[0x7fa6840011a0] main audio output warning: resampling stopped after
14432013 usec (drift: -416)
[0x2d2cf70] main video output warning: late picture skipped (12790 >
-2318)
Reply all
Reply to author
Forward
0 new messages