Postby emagers » 26 Feb 2008 19:01
Log output from one session where VLC played audio but no video below. Hope there's something obvious:
-- logger module started --
main debug: CPU has capabilities FPU
main debug: looking for memcpy module: 1 candidate
main debug: using memcpy module "memcpy"
main debug: waiting for thread completion
main debug: thread 42871808 (playlist) created at priority -47 (playlist/playlist.c:184)
main debug: waiting for thread completion
main debug: thread 42875392 (preparser) created at priority -47 (playlist/playlist.c:210)
main debug: looking for interface module: 1 candidate
main debug: using interface module "hotkeys"
main debug: thread 42038784 (interface) created at priority -47 (interface/interface.c:198)
main debug: looking for interface module: 2 candidates
main debug: using interface module "macosx"
main debug: thread 42881536 (manage) created at priority -47 (interface/interface.c:164)
main debug: looking for interface module: 1 candidate
logger: using logger...
logger warning: no log filename provided, using `/Users/imac/Library/Logs//vlc-log.txt'
logger debug: opening logfile `/Users/imac/Library/Logs//vlc-log.txt'
main debug: using interface module "logger"
main debug: thread 43347456 (interface) created at priority -47 (interface/interface.c:198)
main debug: adding playlist item `The Power Of Nightmares' ( dvdnav:///Volumes/The Power Of Nightmares )
main debug: creating new input thread
main debug: waiting for thread completion
main debug: thread 43652096 (input) created at priority 37 (input/input.c:265)
main debug: creating statistics handler
main debug: `dvdnav:///Volumes/The Power Of Nightmares' gives access `dvdnav' demux `' path `/Volumes/The Power Of Nightmares'
main debug: creating demux: access='dvdnav' demux='' path='/Volumes/The Power Of Nightmares'
main debug: looking for access_demux module: 1 candidate
dvdnav debug: trying to go to dvd menu
main debug: thread 43697152 (dvdnav event thread handler) created at priority -47 (dvdnav.c:336)
main debug: using access_demux module "dvdnav"
main debug: `dvdnav:///Volumes/The Power Of Nightmares' successfully opened
dvdnav debug: DVDNAV_HOP_CHANNEL
dvdnav debug: DVDNAV_VTS_CHANGE
dvdnav debug: - vtsN=1
dvdnav debug: - domain=8
dvdnav debug: DVDNAV_CELL_CHANGE
dvdnav debug: - cellN=1
dvdnav debug: - pgN=1
dvdnav debug: - cell_length=15753000
dvdnav debug: - pg_length=15753000
dvdnav debug: - pgc_length=15753000
dvdnav debug: - cell_start=0
dvdnav debug: - pg_start=0
dvdnav debug: DVDNAV_SPU_CLUT_CHANGE
dvdnav debug: DVDNAV_SPU_STREAM_CHANGE
dvdnav debug: - physical_wide=0
dvdnav debug: - physical_letterbox=0
dvdnav debug: - physical_pan_scan=0
dvdnav debug: buttonUpdate 1
main debug: selecting program id=0
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "spudec"
main debug: thread 43722752 (decoder) created at priority -47 (input/decoder.c:159)
dvdnav debug: DVDNAV_AUDIO_STREAM_CHANGE
dvdnav debug: - physical=0
dvdnav debug: buttonUpdate 1
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "libmpeg2"
main debug: thread 43732992 (decoder) created at priority -47 (input/decoder.c:159)
dvdnav debug: buttonUpdate 1
libmpeg2 debug: 720x480 (display 720,480), aspect 576000, sar 8:9, 29.971 fps
main debug: no usable vout present, spawning one
main debug: crop: 73,337,247,33, palette forced: 1
main debug: window size: 720x540
main debug: looking for video output module: 3 candidates
opengl debug: Texture size: 720x480
main debug: looking for opengl provider module: 1 candidate
macosx warning: no OpenGL hardware acceleration found. Video display will be slow
opengl warning: No OpenGL provider found
macosx debug: we don't have Altivec
main debug: Registering subpicture channel, ID: 2
main debug: Registering subpicture channel, ID: 3
main debug: Registering subpicture channel, ID: 4
main debug: Registering subpicture channel, ID: 5
macosx debug: input has changed, refreshing interface
main debug: Registering subpicture channel, ID: 6
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "a52"
main debug: thread 43926528 (decoder) created at priority 37 (input/decoder.c:159)
a52: A/52 channels:2 samplerate:48000 bitrate:192000
main debug: no aout present, spawning one
main debug: looking for audio output module: 2 candidates
main debug: VLC is looking for: 'a52 ' 48000 Hz Stereo frame=1536 samples/768 bytes
auhal debug: system has [1] device(s)
auhal debug: DevID: 0xa DevName: Built-in Audio
auhal debug: supported format: [44100][lpcm][30][4][1][4][2][16]
macosx error: QT doesn't support any appropriate chroma
main debug: using video output module "dummy"
main debug: waiting for thread completion
main debug: got 8 direct buffer(s)
main debug: picture in 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: picture user 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: picture out 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: direct render, mapping render pictures 0-6 to system pictures 1-7
main debug: thread 44170752 (video output) created at priority 37 (video_output/video_output.c:421)
main warning: dts != current_pts (5527654)
auhal debug: current format is: [44100][lpcm][43][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][lpcm][11][8][1][8][2][32]
auhal debug: the actual set AU format is [48000][lpcm][11][8][1][8][2][32]
main debug: using audio output module "auhal"
main debug: output 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: no need for any filter
main debug: looking for audio mixer module: 3 candidates
main debug: looking for video blending module: 1 candidate
blend debug: chroma: YUVP -> I420
main debug: using video blending module "blend"
main debug: using audio mixer module "trivial_mixer"
main debug: input 'a52 ' 48000 Hz Stereo frame=1536 samples/768 bytes
main debug: filter(s) 'a52 '->'fl32' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "a52tofloat32"
main debug: found a filter for the whole conversion
main debug: filter(s) 'fl32'->'fl32' 52800 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "bandlimited_resampler"
main debug: found a filter for the whole conversion
main warning: PTS is out of range (6009309), dropping buffer
#### REMOVED SEVERAL PAGES OF SIMILAR ERROR HERE ####
main warning: PTS is out of range (10973), dropping buffer
main warning: PTS is out of range (-21002), dropping buffer
dvdnav debug: DVDNAV_NOP
dvdnav debug: DVDNAV_WAIT
dvdnav debug: DVDNAV_NOP
dvdnav debug: DVDNAV_CELL_CHANGE
dvdnav debug: - cellN=1
dvdnav debug: - pgN=1
dvdnav debug: - cell_length=15753000
dvdnav debug: - pg_length=15753000
dvdnav debug: - pgc_length=15753000
dvdnav debug: - cell_start=0
dvdnav debug: - pg_start=0
dvdnav debug: DVDNAV_SPU_CLUT_CHANGE
dvdnav debug: DVDNAV_SPU_STREAM_CHANGE
dvdnav debug: - physical_wide=0
dvdnav debug: - physical_letterbox=0
dvdnav debug: - physical_pan_scan=0
main debug: crop: 73,337,247,33, palette forced: 1
dvdnav debug: buttonUpdate 1
main debug: removing module "spudec"
main debug: thread 43722752 joined (input/decoder.c:191)
main debug: killing decoder fourcc `spu ', 0 PES in FIFO
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "spudec"
main debug: thread 43539968 (decoder) created at priority -47 (input/decoder.c:159)
dvdnav debug: DVDNAV_AUDIO_STREAM_CHANGE
dvdnav debug: - physical=0
main debug: crop: 73,337,247,33, palette forced: 1
dvdnav debug: buttonUpdate 1
libmpeg2 debug: 720x480 (display 720,480), aspect 576000, sar 8:9, 29.971 fps
main warning: dts != current_pts (-93163)
main debug: Registering subpicture channel, ID: 7
main warning: buffer is 60465 in advance, triggering downsampling
main warning: resampling stopped after 13671208 usec (drift: -805)
dvdnav debug: DVDNAV_NOP
dvdnav debug: DVDNAV_WAIT
dvdnav debug: DVDNAV_NOP
dvdnav debug: DVDNAV_CELL_CHANGE
dvdnav debug: - cellN=1
dvdnav debug: - pgN=1
dvdnav debug: - cell_length=15753000
dvdnav debug: - pg_length=15753000
dvdnav debug: - pgc_length=15753000
dvdnav debug: - cell_start=0
dvdnav debug: - pg_start=0
dvdnav debug: DVDNAV_SPU_CLUT_CHANGE
dvdnav debug: DVDNAV_SPU_STREAM_CHANGE
dvdnav debug: - physical_wide=0
dvdnav debug: - physical_letterbox=0
dvdnav debug: - physical_pan_scan=0
main debug: crop: 73,337,247,33, palette forced: 1
dvdnav debug: buttonUpdate 1
main debug: removing module "spudec"
main debug: thread 43539968 joined (input/decoder.c:191)
main debug: killing decoder fourcc `spu ', 0 PES in FIFO
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "spudec"
main debug: thread 43462144 (decoder) created at priority -47 (input/decoder.c:159)
dvdnav debug: DVDNAV_AUDIO_STREAM_CHANGE
dvdnav debug: - physical=0
main debug: crop: 73,337,247,33, palette forced: 1
dvdnav debug: buttonUpdate 1
libmpeg2 debug: 720x480 (display 720,480), aspect 576000, sar 8:9, 29.971 fps
main warning: dts != current_pts (-93272)
main debug: Registering subpicture channel, ID: 8
main warning: buffer is 59310 in advance, triggering downsampling
main warning: resampling stopped after 13505594 usec (drift: -815)
main debug: removing all interfaces
main debug: thread 43347456 joined (interface/interface.c:258)