vlc output

gistfile1.txt

main debug: using interface module "macosx"
main debug: TIMER module_need() : 149.555 ms - Total 149.555 ms / 1 intvls (Avg 149.555 ms)
main debug: playlist threads correctly activated
main debug: rebuilding array of current - root Playlist
main debug: rebuild done - 0 items, index -1
macosx debug: using future AR cookies
main debug: looking for services probe module: 5 candidates
main debug: no services probe module matching "any" could be loaded
main debug: TIMER module_need() : 11.789 ms - Total 11.789 ms / 1 intvls (Avg 11.789 ms)
main debug: looking for extension module: 1 candidate
lua debug: Opening Lua Extension module
lua debug: Trying Lua scripts in /Users/akoldaev/Library/Application Support/org.videolan.vlc/lua/extensions
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/extensions
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/share/lua/extensions
main debug: using extension module "lua"
main debug: TIMER module_need() : 0.784 ms - Total 0.784 ms / 1 intvls (Avg 0.784 ms)
main debug: adding item `CLIP0001.MP4' ( file:///Users/akoldaev/Downloads/CLIP0001.MP4 )
main debug: Creating an input for 'CLIP0001.MP4'
main debug: rebuilding array of current - root Playlist
main debug: rebuild done - 1 items, index -1
main debug: processing request item: CLIP0001.MP4, node: Playlist, skip: 0
main debug: resyncing on CLIP0001.MP4
main debug: CLIP0001.MP4 is at 0
main debug: starting playback of the new playlist item
main debug: creating new input thread
main debug: Creating an input for 'CLIP0001.MP4'
main debug: using timeshift granularity of 50 MiB, in path '/tmp'
main debug: `file:///Users/akoldaev/Downloads/CLIP0001.MP4' gives access `file' demux `' path `/Users/akoldaev/Downloads/CLIP0001.MP4'
main debug: creating demux: access='file' demux='' location='/Users/akoldaev/Downloads/CLIP0001.MP4' file='/Users/akoldaev/Downloads/CLIP0001.MP4'
main debug: looking for access_demux module: 3 candidates
main debug: no access_demux module matching "file" could be loaded
main debug: TIMER module_need() : 0.177 ms - Total 0.177 ms / 1 intvls (Avg 0.177 ms)
main debug: creating access 'file' location='/Users/akoldaev/Downloads/CLIP0001.MP4', path='/Users/akoldaev/Downloads/CLIP0001.MP4'
main debug: looking for access module: 3 candidates
filesystem debug: opening file `/Users/akoldaev/Downloads/CLIP0001.MP4'
main debug: using access module "filesystem"
main debug: TIMER module_need() : 0.176 ms - Total 0.176 ms / 1 intvls (Avg 0.176 ms)
main debug: Using stream method for AStream*
main debug: starting pre-buffering
main debug: received first data after 0 ms
main debug: pre-buffering done 1024 bytes in 0s - 21276 KiB/s
main debug: looking for stream_filter module: 7 candidates
main debug: no stream_filter module matching "any" could be loaded
main debug: TIMER module_need() : 0.132 ms - Total 0.132 ms / 1 intvls (Avg 0.132 ms)
main debug: looking for stream_filter module: 1 candidate
main debug: using stream_filter module "stream_filter_record"
main debug: TIMER module_need() : 0.118 ms - Total 0.118 ms / 1 intvls (Avg 0.118 ms)
main debug: creating demux: access='file' demux='' location='/Users/akoldaev/Downloads/CLIP0001.MP4' file='/Users/akoldaev/Downloads/CLIP0001.MP4'
main debug: looking for demux module: 55 candidates
mp4 warning: unknown box type uuid (incompletely loaded)
mp4 warning: unknown box type uuid (incompletely loaded)
mp4 warning: unknown box type uuid (incompletely loaded)
mp4 debug: dumping root Box "root"
mp4 debug: |   + ftyp size 28
mp4 debug: |   + uuid size 148
mp4 debug: |   + mdat size 3574641
mp4 debug: |   + moov size 4440
mp4 debug: |   |   + mvhd size 108
mp4 debug: |   |   + trak size 1884
mp4 debug: |   |   |   + tkhd size 92
mp4 debug: |   |   |   + edts size 36
mp4 debug: |   |   |   |   + elst size 28
mp4 debug: |   |   |   + mdia size 1696
mp4 debug: |   |   |   |   + mdhd size 32
mp4 debug: |   |   |   |   + hdlr size 53
mp4 debug: |   |   |   |   + minf size 1603
mp4 debug: |   |   |   |   |   + vmhd size 20
mp4 debug: |   |   |   |   |   + dinf size 36
mp4 debug: |   |   |   |   |   |   + dref size 28
mp4 debug: |   |   |   |   |   |   |   + url  size 12
mp4 debug: |   |   |   |   |   + stbl size 1539
mp4 debug: |   |   |   |   |   |   + stsd size 135
mp4 debug: |   |   |   |   |   |   |   + avc1 size 119
mp4 debug: |   |   |   |   |   |   |   |   + avcC size 33
mp4 debug: |   |   |   |   |   |   + stts size 24
mp4 debug: |   |   |   |   |   |   + ctts size 24
mp4 debug: |   |   |   |   |   |   + stsc size 28
mp4 debug: |   |   |   |   |   |   + stsz size 632
mp4 debug: |   |   |   |   |   |   + stco size 628
mp4 debug: |   |   |   |   |   |   + stss size 60
mp4 debug: |   |   |   + uuid size 52
mp4 debug: |   |   + trak size 2440
mp4 debug: |   |   |   + tkhd size 92
mp4 debug: |   |   |   + edts size 36
mp4 debug: |   |   |   |   + elst size 28
mp4 debug: |   |   |   + mdia size 2252
mp4 debug: |   |   |   |   + mdhd size 32
mp4 debug: |   |   |   |   + hdlr size 53
mp4 debug: |   |   |   |   + minf size 2159
mp4 debug: |   |   |   |   |   + smhd size 16
mp4 debug: |   |   |   |   |   + dinf size 36
mp4 debug: |   |   |   |   |   |   + dref size 28
mp4 debug: |   |   |   |   |   |   |   + url  size 12
mp4 debug: |   |   |   |   |   + stbl size 2099
mp4 debug: |   |   |   |   |   |   + stsd size 91
mp4 debug: |   |   |   |   |   |   |   + mp4a size 75
mp4 debug: |   |   |   |   |   |   |   |   + esds size 39
mp4 debug: |   |   |   |   |   |   + stts size 24
mp4 debug: |   |   |   |   |   |   + stsc size 28
mp4 debug: |   |   |   |   |   |   + stsz size 976
mp4 debug: |   |   |   |   |   |   + stco size 972
mp4 debug: |   |   |   + uuid size 52
mp4 debug: unrecognized major file specification (MSNV).
mp4 debug: found 2 tracks
mp4 warning: elst box found
mp4 debug:    - [0] duration=5105ms media time=33ms) rate=1.0
mp4 debug: track[Id 0x1] read 153 chunk
mp4 warning: CTTS table
mp4 debug: track[Id 0x1] read 153 samples length:5s
main debug: selecting program id=0
mp4 debug: adding track[Id 0x1] video (enable) language jpn
mp4 warning: elst box found
mp4 debug:    - [0] duration=5098ms media time=0ms) rate=1.0
mp4 debug: track[Id 0x2] read 239 chunk
mp4 debug: track[Id 0x2] read 239 samples length:5s
mp4 debug: adding track[Id 0x2] audio (enable) language jpn
main debug: using demux module "mp4"
main debug: TIMER module_need() : 10.550 ms - Total 10.550 ms / 1 intvls (Avg 10.550 ms)
main debug: looking for a subtitle file in /Users/akoldaev/Downloads
main debug: looking for decoder module: 31 candidates
main debug: no fetch required for (null) (art currently (null))
main debug: no fetch required for (null) (art currently (null))
avcodec debug: libavcodec initialized (interface 0x360a64)
avcodec debug: trying to use direct rendering
avcodec debug: allowing 4 thread(s) for decoding
avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started
avcodec debug: using frame thread mode with 4 threads
main debug: using decoder module "avcodec"
main debug: TIMER module_need() : 165.120 ms - Total 165.120 ms / 1 intvls (Avg 165.120 ms)
main debug: looking for decoder module: 31 candidates
main debug: using decoder module "faad"
main debug: TIMER module_need() : 29.828 ms - Total 29.828 ms / 1 intvls (Avg 29.828 ms)
main debug: looking for meta reader module: 2 candidates
lua debug: Trying Lua scripts in /Users/akoldaev/Library/Application Support/org.videolan.vlc/lua/meta/reader
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader/filename.luac
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/share/lua/meta/reader
main debug: no meta reader module matching "any" could be loaded
main debug: TIMER module_need() : 1.189 ms - Total 1.189 ms / 1 intvls (Avg 1.189 ms)
main debug: `file:///Users/akoldaev/Downloads/CLIP0001.MP4' successfully opened
mp4 debug: elst (0) gives 0ms (movie)-> 33ms (track)
mp4 debug: track[Id 0x1] using Sync Sample Box (stss)
mp4 debug: stts gives 1 --> 0 (sample number)
mp4 debug: elst (0) gives 0ms (movie)-> 0ms (track)
mp4 debug: track[Id 0x2] does not provide Sync Sample Box (stss)
main debug: Buffering 0%
main debug: Buffering 0%
main debug: Buffering 10%
main debug: looking for text renderer module: 3 candidates
main debug: Buffering 20%
faad warning: decoded zero sample
main debug: Buffering 30%
freetype debug: Building font databases.
main debug: Buffering 40%
main debug: Buffering 50%
main debug: Buffering 60%
main debug: Buffering 70%
main debug: Buffering 80%
main debug: Buffering 90%
main debug: Buffering 100%
main debug: Stream buffering done (1100 ms in 109 ms)
macosx debug: Found 1 capture devices
freetype debug: Took 357779 microseconds
freetype debug: Using Arial Unicode MS as font from file /Library/Fonts/Arial Unicode.ttf
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: TIMER module_need() : 427.788 ms - Total 427.788 ms / 1 intvls (Avg 427.788 ms)
main debug: looking for video filter2 module: 18 candidates
swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality)
main debug: using video filter2 module "swscale"
main debug: TIMER module_need() : 10.981 ms - Total 10.981 ms / 1 intvls (Avg 10.981 ms)
main debug: looking for video filter2 module: 18 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: TIMER module_need() : 20.734 ms - Total 20.734 ms / 1 intvls (Avg 20.734 ms)
main debug: Deinterlacing available
main debug: deinterlace 0, mode blend, is_needed 0
main debug: Opening vout display wrapper
main debug: looking for vout display module: 2 candidates
vout_macosx debug: Quartz Extreme acceleration is active
main debug: looking for vout window nsobject module: 1 candidate
macosx debug: returning videoview with x=0, y=36, width=720, height=310
main debug: using vout window nsobject module "macosx"
main debug: TIMER module_need() : 0.326 ms - Total 0.326 ms / 1 intvls (Avg 0.326 ms)
main debug: VoutDisplayEvent 'fullscreen' 0
main debug: VoutDisplayEvent 'resize' 1280x720 window
main debug: using vout display module "vout_macosx"
main debug: TIMER module_need() : 18.832 ms - Total 18.832 ms / 1 intvls (Avg 18.832 ms)
main debug: original format sz 1280x720, of (0,0), vsz 1280x720, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
main debug: removing module "freetype"
main debug: looking for text renderer module: 3 candidates
freetype debug: Building font databases.
freetype debug: Took 26468 microseconds
freetype debug: Using Arial Unicode MS as font from file /Library/Fonts/Arial Unicode.ttf
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: TIMER module_need() : 30.111 ms - Total 30.111 ms / 1 intvls (Avg 30.111 ms)
avcodec debug: using direct rendering
main debug: creating audio output
main debug: looking for audio output module: 1 candidate
main debug: VLC is looking for: 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
auhal debug: found 4 audio device(s)
auhal debug: DevID: 64 DevName: Built-in Microphone
auhal debug: this device is INPUT only. skipping...
auhal debug: DevID: 54 DevName: Built-in Output
auhal debug: found 16 stream formats
auhal debug: supported format: [96000.000000][mcpl][4][8][1][8][2][24]
auhal debug: supported format: [88200.000000][mcpl][4][8][1][8][2][24]
auhal debug: supported format: [48000.000000][mcpl][4][8][1][8][2][24]
auhal debug: supported format: [44100.000000][mcpl][4][8][1][8][2][24]
auhal debug: supported format: [96000.000000][mcpl][4][8][1][8][2][20]
auhal debug: supported format: [88200.000000][mcpl][4][8][1][8][2][20]
auhal debug: supported format: [48000.000000][mcpl][4][8][1][8][2][20]
auhal debug: supported format: [44100.000000][mcpl][4][8][1][8][2][20]
auhal debug: supported format: [96000.000000][mcpl][12][4][1][4][2][16]
auhal debug: supported format: [88200.000000][mcpl][12][4][1][4][2][16]
auhal debug: supported format: [48000.000000][mcpl][12][4][1][4][2][16]
auhal debug: supported format: [44100.000000][mcpl][12][4][1][4][2][16]
auhal debug: supported format: [96000.000000][mcpl][9][8][1][8][2][32]
auhal debug: supported format: [88200.000000][mcpl][9][8][1][8][2][32]
auhal debug: supported format: [48000.000000][mcpl][9][8][1][8][2][32]
auhal debug: supported format: [44100.000000][mcpl][9][8][1][8][2][32]
auhal debug: DevID: 75 DevName: After Effects 10.5
auhal debug: this device is INPUT only. skipping...
auhal debug: DevID: 74 DevName: Premiere Pro 5.5
auhal debug: this device is INPUT only. skipping...
auhal debug: current format is: [44100.000000][mcpl][41][4][1][4][2][32]
auhal debug: layout of AUHAL has 2 channels
auhal debug: selected 2 physical channels for device output
auhal debug: VLC will output: Stereo
auhal debug: we set the AU format: [48000.000000][mcpl][9][8][1][8][2][32]
auhal debug: the actual set AU format is [48000.000000][mcpl][9][8][1][8][2][32]
main debug: End of video preroll
main debug: Received first picture
auhal debug: analog output successfully opened
main debug: using audio output module "auhal"
main debug: TIMER module_need() : 55.694 ms - Total 55.694 ms / 1 intvls (Avg 55.694 ms)
main debug: output 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: mixer 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: conversion pipeline completed
main debug: looking for audio mixer module: 2 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 2.125 ms - Total 2.125 ms / 1 intvls (Avg 2.125 ms)
main debug: input 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio filter module: 1 candidate
scaletempo debug: format: 48000 rate, 2 nch, 4 bps, fl32
scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode
main debug: using audio filter module "scaletempo"
main debug: TIMER module_need() : 7.248 ms - Total 7.248 ms / 1 intvls (Avg 7.248 ms)
main debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: conversion pipeline completed
main debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: conversion pipeline completed
main debug: filter(s) 'f32l'->'f32l' 52800 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 14 candidates
main debug: Post-processing available
main debug: using audio filter module "samplerate"
main debug: TIMER module_need() : 99.592 ms - Total 99.592 ms / 1 intvls (Avg 99.592 ms)
main debug: conversion pipeline completed
main debug: End of audio preroll
main debug: Decoder buffering done in 594 ms
main warning: PTS is out of range (-31309), dropping buffer
main warning: picture is too late to be displayed (missing 34 ms)
main debug: picture might be displayed late (missing 0 ms)
main debug: audio output is too slow (162028 us):  trashing 42666 us
main debug: audio output is too slow (119362 us):  trashing 42666 us
main debug: audio output is too slow (76696 us):  trashing 42667 us
main debug: audio output is too slow (34029 us):  trashing 42667 us
main warning: audio output out of sync, adjusting dates (62175 us)
main warning: picture is too late to be displayed (missing 208 ms)
main warning: picture is too late to be displayed (missing 175 ms)
main warning: picture is too late to be displayed (missing 142 ms)
main warning: picture is too late to be displayed (missing 108 ms)
main warning: picture is too late to be displayed (missing 75 ms)
main warning: picture is too late to be displayed (missing 42 ms)
main debug: picture might be displayed late (missing 8 ms)
main warning: not synchronized (62175 us), resampling
main warning: buffer too late  (61758), up-sampling
main warning: picture is too late to be displayed (missing 38 ms)
main debug: picture might be displayed late (missing 5 ms)
main warning: picture is too late to be displayed (missing 144 ms)
main warning: picture is too late to be displayed (missing 111 ms)
main warning: picture is too late to be displayed (missing 78 ms)
main warning: picture is too late to be displayed (missing 44 ms)
main debug: picture might be displayed late (missing 11 ms)
macosx debug: no optical media found
main debug: VoutDisplayEvent 'mouse button' 0 t=8
main debug: picture might be displayed late (missing 1 ms)
main debug: picture might be displayed late (missing 3 ms)
main debug: picture might be displayed late (missing 16 ms)
main debug: picture might be displayed late (missing 16 ms)
main debug: VoutDisplayEvent 'mouse button' 0 t=9
main debug: auto hiding mouse cursor