vlc audio dropping out when using with safari

[juan.vesa]

hello,

theres a repeated problem i have with VLC 2.01 on os x lion 10.7.3 on mac book pro 2.4G/core-i7 in conjunction with safari 5.1.5. when i play audio files, either flac or mp3, the audio drops out frequently, but particularly when loading web pages, and just after a web page has finished loading. could someone offer some assistance to to get this sorted please,

thanks

[nkoriyama]

Please share the log when audio dropping. It's in a message window(Window -> Messages).

[juan.vesa]

hi, heres a short snippett, thanks

Code: Select all

main debug: incoming request - stopping current input main debug: dying input main debug: control: stopping input main debug: dying input main debug: removing module "flac" main debug: killing decoder fourcc `flac', 0 PES in FIFO main debug: removing module "audio_format" main debug: removing module "scaletempo" main debug: removing module "samplerate" main debug: removing module "auhal" main debug: removing module "float32_mixer" main debug: releasing audio output main debug: removing module "flacsys" main debug: removing module "packetizer_flac" main debug: removing module "stream_filter_record" main debug: removing module "filesystem" main debug: Program doesn't contain anymore ES main debug: dead input main debug: processing request item: Track01, node: Playlist, skip: 0 main debug: rebuilding array of current - root Playlist main debug: rebuild done - 47 items, index 43 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'Track01' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac' gives access `file' demux `' path `/Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac' main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac' file='/Users/s3158311/Downloads/Untitled 03/01 - Untitled.flac' 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.158 ms - Total 0.158 ms / 1 intvls (Avg 0.158 ms) main debug: creating access 'file' location='/Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac', path='/Users/s3158311/Downloads/Untitled 03/01 - Untitled.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/s3158311/Downloads/Untitled 03/01 - Untitled.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.126 ms - Total 0.126 ms / 1 intvls (Avg 0.126 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 - 33333 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.091 ms - Total 0.091 ms / 1 intvls (Avg 0.091 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.079 ms - Total 0.079 ms / 1 intvls (Avg 0.079 ms) main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac' file='/Users/s3158311/Downloads/Untitled 03/01 - Untitled.flac' main debug: ID3v2.3 revision 0 tag found, skipping 4492 bytes main debug: looking for demux module: 55 candidates main debug: looking for packetizer module: 21 candidates main debug: using packetizer module "packetizer_flac" main debug: TIMER module_need() : 0.090 ms - Total 0.090 ms / 1 intvls (Avg 0.090 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.228 ms - Total 0.228 ms / 1 intvls (Avg 0.228 ms) main debug: looking for a subtitle file in /Users/s3158311/Downloads/Untitled 03 main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 0.875 ms - Total 0.875 ms / 1 intvls (Avg 0.875 ms) main debug: removing module "taglib" main debug: `file:///Users/s3158311/Downloads/Untitled%2003/01%20-%20Untitled.flac' successfully opened main debug: selecting program id=0 main debug: looking for decoder module: 31 candidates main debug: using decoder module "flac" main debug: TIMER module_need() : 0.343 ms - Total 0.343 ms / 1 intvls (Avg 0.343 ms) main debug: Buffering 0% main debug: Buffering 9% flac debug: decode STREAMINFO main debug: Buffering 18% flac debug: channels:2 samplerate:44100 bitspersamples:16 flac debug: STREAMINFO decoded main debug: recycling audio output main debug: looking for audio output module: 1 candidate main debug: Buffering 27% main debug: VLC is looking for: 's16l' 44100 Hz Stereo frame=1 samples/4 bytes auhal debug: found 3 audio device(s) main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: TIMER input launching for 'Track02' : 34.509 ms - Total 34.509 ms / 1 intvls (Avg 34.509 ms) main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 3 ms) auhal debug: DevID: 52 DevName: Built-in Microphone auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 42 DevName: Built-in Input auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 34 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 warning: audio device already in use 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: [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 8.658 ms - Total 8.658 ms / 1 intvls (Avg 8.658 ms) main debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 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() : 0.138 ms - Total 0.138 ms / 1 intvls (Avg 0.138 ms) main debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 44100 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.185 ms - Total 0.185 ms / 1 intvls (Avg 0.185 ms) main debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.134 ms - Total 0.134 ms / 1 intvls (Avg 0.134 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.129 ms - Total 0.129 ms / 1 intvls (Avg 0.129 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 8 ms main warning: PTS is out of range (-9957), dropping buffer main warning: audio output out of sync, adjusting dates (-46102 us) main warning: not synchronized (-46102 us), resampling main warning: buffer too early (-46557), down-sampling main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1000 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: Buffering 9% main debug: End of audio preroll main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 27 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82892), dropping buffer main warning: PTS is out of range (-9950), dropping buffer main debug: audio output is starving (-73138), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1029 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 9% main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 36% main debug: Buffering 45% main debug: Buffering 54% main debug: Buffering 63% main debug: Buffering 72% main debug: Buffering 81% main debug: Buffering 90% main debug: Buffering 99% main debug: Stream buffering done (1114 ms in 146 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82926), dropping buffer main warning: PTS is out of range (-9906), dropping buffer main debug: audio output is starving (-73294), playing silence main warning: PTS is out of range (-10641), dropping buffer main warning: buffer too early (-92880), down-sampling main debug: audio output is too slow (28295 us): trashing 46440 us main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1220 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: Buffering 7% main debug: End of audio preroll main debug: Buffering 15% main debug: Buffering 22% main debug: Buffering 30% main debug: Buffering 38% main debug: Buffering 45% main debug: Buffering 53% main debug: Buffering 60% main debug: Buffering 68% main debug: Buffering 76% main debug: Buffering 83% main debug: Buffering 91% main debug: Buffering 98% main debug: Stream buffering done (1300 ms in 2127 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82894), dropping buffer main warning: PTS is out of range (-9950), dropping buffer main debug: audio output is starving (-80525), playing silence main warning: audio output out of sync, adjusting dates (-45691 us) main warning: not synchronized (-45691 us), resampling main warning: buffer too early (-45692), down-sampling main warning: resampling stopped after 19448597 usec (drift: -907) main debug: EOF reached main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: waiting decoder fifos to empty main debug: finished input main debug: removing module "flac" main debug: killing decoder fourcc `flac', 0 PES in FIFO main debug: removing module "audio_format" main debug: removing module "scaletempo" main debug: removing module "samplerate" main debug: removing module "auhal" main debug: removing module "float32_mixer" main debug: releasing audio output main debug: removing module "flacsys" main debug: removing module "packetizer_flac" main debug: removing module "stream_filter_record" main debug: removing module "filesystem" main debug: Program doesn't contain anymore ES main debug: dead input main debug: changing item without a request (current 43/47) main debug: using item 44 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'Track02' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac' gives access `file' demux `' path `/Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac' main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac' file='/Users/s3158311/Downloads/Untitled 03/02 - Untitled.flac' 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.140 ms - Total 0.140 ms / 1 intvls (Avg 0.140 ms) main debug: creating access 'file' location='/Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac', path='/Users/s3158311/Downloads/Untitled 03/02 - Untitled.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/s3158311/Downloads/Untitled 03/02 - Untitled.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.104 ms - Total 0.104 ms / 1 intvls (Avg 0.104 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 - 29411 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.088 ms - Total 0.088 ms / 1 intvls (Avg 0.088 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.062 ms - Total 0.062 ms / 1 intvls (Avg 0.062 ms) main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac' file='/Users/s3158311/Downloads/Untitled 03/02 - Untitled.flac' main debug: ID3v2.3 revision 0 tag found, skipping 4494 bytes main debug: looking for demux module: 55 candidates main debug: looking for packetizer module: 21 candidates main debug: using packetizer module "packetizer_flac" main debug: TIMER module_need() : 0.067 ms - Total 0.067 ms / 1 intvls (Avg 0.067 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.211 ms - Total 0.211 ms / 1 intvls (Avg 0.211 ms) main debug: looking for a subtitle file in /Users/s3158311/Downloads/Untitled 03 main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 0.761 ms - Total 0.761 ms / 1 intvls (Avg 0.761 ms) main debug: removing module "taglib" main debug: `file:///Users/s3158311/Downloads/Untitled%2003/02%20-%20Untitled.flac' successfully opened main debug: selecting program id=0 main debug: looking for decoder module: 31 candidates main debug: using decoder module "flac" main debug: TIMER module_need() : 0.187 ms - Total 0.187 ms / 1 intvls (Avg 0.187 ms) main debug: Buffering 0% flac debug: decode STREAMINFO flac debug: channels:2 samplerate:44100 bitspersamples:16 flac debug: STREAMINFO decoded main debug: Buffering 9% main debug: recycling audio output main debug: looking for audio output module: 1 candidate main debug: VLC is looking for: 's16l' 44100 Hz Stereo frame=1 samples/4 bytes auhal debug: found 3 audio device(s) main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% auhal debug: DevID: 52 DevName: Built-in Microphone auhal debug: this device is INPUT only. skipping... main debug: Buffering 65% auhal debug: DevID: 42 DevName: Built-in Input auhal debug: this device is INPUT only. skipping... main debug: Buffering 74% auhal debug: DevID: 34 DevName: Built-in Output main debug: Buffering 83% 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 warning: audio device already in use main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 3 ms) 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: [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 6.460 ms - Total 6.460 ms / 1 intvls (Avg 6.460 ms) main debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 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() : 0.155 ms - Total 0.155 ms / 1 intvls (Avg 0.155 ms) main debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 44100 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.212 ms - Total 0.212 ms / 1 intvls (Avg 0.212 ms) main debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.153 ms - Total 0.153 ms / 1 intvls (Avg 0.153 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.155 ms - Total 0.155 ms / 1 intvls (Avg 0.155 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 5 ms main warning: PTS is out of range (-9990), dropping buffer main debug: TIMER input launching for 'Track01' : 2.527 ms - Total 2.527 ms / 1 intvls (Avg 2.527 ms) main warning: audio output out of sync, adjusting dates (-45996 us) main warning: not synchronized (-45996 us), resampling main warning: buffer too early (-46451), down-sampling main warning: resampling stopped after 19687739 usec (drift: -1033) main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1000 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 9% main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 1597 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82894), dropping buffer main warning: PTS is out of range (-9940), dropping buffer main debug: audio output is starving (-74902), playing silence main warning: audio output out of sync, adjusting dates (-40060 us) main warning: not synchronized (-40060 us), resampling main warning: buffer too early (-40061), down-sampling main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1128 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 8% main debug: Buffering 16% main debug: Buffering 24% main debug: Buffering 32% main debug: Buffering 41% main debug: Buffering 49% main debug: Buffering 57% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 82% main debug: Buffering 90% main debug: Buffering 98% main debug: Stream buffering done (1207 ms in 399 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82903), dropping buffer main warning: PTS is out of range (-9898), dropping buffer main debug: audio output is starving (-70101), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1335 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 6% main debug: Buffering 13% main debug: Buffering 20% main debug: Buffering 27% main debug: Buffering 34% main debug: Buffering 41% main debug: Buffering 48% main debug: Buffering 55% main debug: Buffering 62% main debug: Buffering 69% main debug: Buffering 76% main debug: Buffering 83% main debug: Buffering 90% main debug: Buffering 97% main debug: Stream buffering done (1393 ms in 125 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82927), dropping buffer main warning: PTS is out of range (-9913), dropping buffer main debug: audio output is starving (-78027), playing silence main warning: audio output out of sync, adjusting dates (-43199 us) main warning: not synchronized (-43199 us), resampling main warning: buffer too early (-43199), down-sampling main warning: resampling stopped after 18300579 usec (drift: -745) main debug: audio output is too slow (120284 us): trashing 46440 us main debug: audio output is too slow (73844 us): trashing 46440 us main debug: audio output is too slow (27404 us): trashing 46440 us

[nkoriyama]

How about disabling "Enable time stretching audio"? (Preferences-> All -> Audio)

[juan.vesa]

hi it appears it's still happening, heres a another log with 'enable time stretching audio' turned to off

Code: Select all

lua debug: Trying Lua scripts in /Users/s3158311/Library/Application Support/org.videolan.vlc/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.214 ms - Total 0.214 ms / 1 intvls (Avg 0.214 ms) macosx debug: Found 1 capture devices macosx warning: unknown disk type, no idea what to display main debug: opening config file (/Users/s3158311/Library/Preferences/org.videolan.vlc/vlcrc) main debug: adding item `01 - A Trick of the Sea.flac' ( file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac ) main debug: Creating an input for '01 - A Trick of the Sea.flac' main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index -1 main debug: processing request item: 01 - A Trick of the Sea.flac, node: Playlist, skip: 0 main debug: resyncing on 01 - A Trick of the Sea.flac main debug: 01 - A Trick of the Sea.flac is at 0 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for '01 - A Trick of the Sea.flac' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' gives access `file' demux `' path `/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' 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.222 ms - Total 0.222 ms / 1 intvls (Avg 0.222 ms) main debug: creating access 'file' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac', path='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.236 ms - Total 0.236 ms / 1 intvls (Avg 0.236 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 - 14705 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.156 ms - Total 0.156 ms / 1 intvls (Avg 0.156 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.144 ms - Total 0.144 ms / 1 intvls (Avg 0.144 ms) main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: looking for demux module: 55 candidates main debug: looking for packetizer module: 21 candidates main debug: adding item `02 - Halloween Boat.flac' ( file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac ) main debug: incoming request - stopping current input main debug: dying input main debug: using packetizer module "packetizer_flac" main debug: TIMER module_need() : 262.165 ms - Total 262.165 ms / 1 intvls (Avg 262.165 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 369.298 ms - Total 369.298 ms / 1 intvls (Avg 369.298 ms) main debug: looking for a subtitle file in /Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac) main debug: looking for meta reader module: 2 candidates main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: using meta reader module "taglib" main debug: Creating an input for '02 - Halloween Boat.flac' main debug: TIMER module_need() : 72.056 ms - Total 72.056 ms / 1 intvls (Avg 72.056 ms) main debug: removing module "taglib" main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' successfully opened main debug: dying input main debug: dying input main debug: removing module "flacsys" main debug: removing module "packetizer_flac" main debug: removing module "stream_filter_record" main debug: removing module "filesystem" main debug: dead input main debug: TIMER input launching for '01 - A Trick of the Sea.flac' : 443.550 ms - Total 443.550 ms / 1 intvls (Avg 443.550 ms) main debug: processing request item: 02 - Halloween Boat.flac, node: Playlist, skip: 0 main debug: rebuilding array of current - root Playlist main debug: rebuild done - 2 items, index 1 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for '02 - Halloween Boat.flac' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac' gives access `file' demux `' path `/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac' main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/02 - Halloween Boat.flac' 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.175 ms - Total 0.175 ms / 1 intvls (Avg 0.175 ms) main debug: creating access 'file' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac', path='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/02 - Halloween Boat.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/02 - Halloween Boat.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.191 ms - Total 0.191 ms / 1 intvls (Avg 0.191 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 - 22222 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.130 ms - Total 0.130 ms / 1 intvls (Avg 0.130 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.136 ms - Total 0.136 ms / 1 intvls (Avg 0.136 ms) main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/02 - Halloween Boat.flac' main debug: looking for demux module: 55 candidates main debug: looking for packetizer module: 21 candidates main debug: using packetizer module "packetizer_flac" main debug: TIMER module_need() : 0.080 ms - Total 0.080 ms / 1 intvls (Avg 0.080 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.401 ms - Total 0.401 ms / 1 intvls (Avg 0.401 ms) main debug: looking for a subtitle file in /Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac) main debug: looking for meta reader module: 2 candidates main debug: no fetch required for Halloween Boat (art currently (null)) main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: no fetch required for A Trick of the Sea (art currently (null)) main debug: using meta reader module "taglib" main debug: TIMER module_need() : 12.841 ms - Total 12.841 ms / 1 intvls (Avg 12.841 ms) main debug: removing module "taglib" main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/02%20-%20Halloween%20Boat.flac' successfully opened main debug: selecting program id=0 main debug: looking for decoder module: 31 candidates main debug: using decoder module "flac" main debug: TIMER module_need() : 98.594 ms - Total 98.594 ms / 1 intvls (Avg 98.594 ms) main debug: Buffering 0% main debug: Buffering 9% flac debug: decode STREAMINFO main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 1 ms) flac debug: channels:2 samplerate:44100 bitspersamples:16 flac debug: STREAMINFO decoded main debug: creating audio output main debug: looking for audio output module: 1 candidate main debug: VLC is looking for: 's16l' 44100 Hz Stereo frame=1 samples/4 bytes auhal debug: found 3 audio device(s) auhal debug: DevID: 52 DevName: Built-in Microphone auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 42 DevName: Built-in Input auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 34 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: 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: [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 80.345 ms - Total 80.345 ms / 1 intvls (Avg 80.345 ms) main debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 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() : 24.528 ms - Total 24.528 ms / 1 intvls (Avg 24.528 ms) main debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: looking for audio filter module: 1 candidate equalizer debug: equalizer loaded for 44100 Hz with 10 bands 1 pass equalizer debug: 60 Hz -> factor:0.000000 alpha:0.003013 beta:0.993973 gamma:1.993901 equalizer debug: 170 Hz -> factor:0.000000 alpha:0.008490 beta:0.983019 gamma:1.982437 equalizer debug: 310 Hz -> factor:0.000000 alpha:0.015374 beta:0.969252 gamma:1.967331 equalizer debug: 600 Hz -> factor:0.000000 alpha:0.029328 beta:0.941343 gamma:1.934254 equalizer debug: 1000 Hz -> factor:0.000000 alpha:0.047918 beta:0.904163 gamma:1.884869 equalizer debug: 3000 Hz -> factor:0.000000 alpha:0.130408 beta:0.739184 gamma:1.582718 equalizer debug: 6000 Hz -> factor:0.000000 alpha:0.226555 beta:0.546889 gamma:1.015267 equalizer debug: 12000 Hz -> factor:0.000000 alpha:0.344937 beta:0.310127 gamma:-0.181410 equalizer debug: 14000 Hz -> factor:0.000000 alpha:0.366438 beta:0.267123 gamma:-0.521151 equalizer debug: 16000 Hz -> factor:0.000000 alpha:0.379009 beta:0.241981 gamma:-0.808451 main debug: using audio filter module "equalizer" main debug: TIMER module_need() : 53.655 ms - Total 53.655 ms / 1 intvls (Avg 53.655 ms) main debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 251.018 ms - Total 251.018 ms / 1 intvls (Avg 251.018 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 9.706 ms - Total 9.706 ms / 1 intvls (Avg 9.706 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 423 ms main warning: PTS is out of range (-9985), dropping buffer main debug: incoming request - stopping current input main debug: dying input main debug: control: stopping input main debug: dying input main debug: removing module "flac" main debug: killing decoder fourcc `flac', 0 PES in FIFO main debug: removing module "audio_format" main debug: removing module "equalizer" main debug: removing module "samplerate" main debug: removing module "auhal" main debug: removing module "float32_mixer" main debug: releasing audio output main debug: removing module "flacsys" main debug: removing module "packetizer_flac" main debug: removing module "stream_filter_record" main debug: removing module "filesystem" main debug: Program doesn't contain anymore ES main debug: dead input main debug: processing request item: A Trick of the Sea, node: Playlist, skip: 0 main debug: resyncing on A Trick of the Sea main debug: A Trick of the Sea is at 0 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'A Trick of the Sea' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' gives access `file' demux `' path `/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' 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.336 ms - Total 0.336 ms / 1 intvls (Avg 0.336 ms) main debug: creating access 'file' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac', path='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.311 ms - Total 0.311 ms / 1 intvls (Avg 0.311 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 - 13888 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.196 ms - Total 0.196 ms / 1 intvls (Avg 0.196 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.181 ms - Total 0.181 ms / 1 intvls (Avg 0.181 ms) main debug: creating demux: access='file' demux='' location='/Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' file='/Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac)/01 - A Trick of the Sea.flac' main debug: looking for demux module: 55 candidates main debug: looking for packetizer module: 21 candidates main debug: using packetizer module "packetizer_flac" main debug: TIMER module_need() : 0.223 ms - Total 0.223 ms / 1 intvls (Avg 0.223 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.672 ms - Total 0.672 ms / 1 intvls (Avg 0.672 ms) main debug: looking for a subtitle file in /Users/s3158311/Downloads/Piano Magic - A Trick Of The Sea (Bliss Out Vol. 13) [Darla Records] [DRL074] (1998) (Flac) main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 1.233 ms - Total 1.233 ms / 1 intvls (Avg 1.233 ms) main debug: removing module "taglib" main debug: `file:///Users/s3158311/Downloads/Piano%20Magic%20-%20A%20Trick%20Of%20The%20Sea%20%28Bliss%20Out%20Vol.%2013%29%20%5BDarla%20Records%5D%20%5BDRL074%5D%20%281998%29%20%28Flac%29/01%20-%20A%20Trick%20of%20the%20Sea.flac' successfully opened main debug: selecting program id=0 main debug: looking for decoder module: 31 candidates main debug: using decoder module "flac" main debug: TIMER module_need() : 0.268 ms - Total 0.268 ms / 1 intvls (Avg 0.268 ms) main debug: Buffering 0% flac debug: decode STREAMINFO flac debug: channels:2 samplerate:44100 bitspersamples:16 main debug: Buffering 9% flac debug: STREAMINFO decoded main debug: Buffering 18% main debug: recycling audio output main debug: Buffering 27% main debug: looking for audio output module: 1 candidate main debug: VLC is looking for: 's16l' 44100 Hz Stereo frame=1 samples/4 bytes auhal debug: found 3 audio device(s) main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 1 ms) auhal debug: DevID: 52 DevName: Built-in Microphone auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 42 DevName: Built-in Input auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 34 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 warning: audio device already in use 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: [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [44100.000000][mcpl][9][8][1][8][2][32] auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 6.386 ms - Total 6.386 ms / 1 intvls (Avg 6.386 ms) main debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 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() : 0.079 ms - Total 0.079 ms / 1 intvls (Avg 0.079 ms) main debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: looking for audio filter module: 1 candidate equalizer debug: equalizer loaded for 44100 Hz with 10 bands 1 pass equalizer debug: 60 Hz -> factor:0.000000 alpha:0.003013 beta:0.993973 gamma:1.993901 equalizer debug: 170 Hz -> factor:0.000000 alpha:0.008490 beta:0.983019 gamma:1.982437 equalizer debug: 310 Hz -> factor:0.000000 alpha:0.015374 beta:0.969252 gamma:1.967331 equalizer debug: 600 Hz -> factor:0.000000 alpha:0.029328 beta:0.941343 gamma:1.934254 equalizer debug: 1000 Hz -> factor:0.000000 alpha:0.047918 beta:0.904163 gamma:1.884869 equalizer debug: 3000 Hz -> factor:0.000000 alpha:0.130408 beta:0.739184 gamma:1.582718 equalizer debug: 6000 Hz -> factor:0.000000 alpha:0.226555 beta:0.546889 gamma:1.015267 equalizer debug: 12000 Hz -> factor:0.000000 alpha:0.344937 beta:0.310127 gamma:-0.181410 equalizer debug: 14000 Hz -> factor:0.000000 alpha:0.366438 beta:0.267123 gamma:-0.521151 equalizer debug: 16000 Hz -> factor:0.000000 alpha:0.379009 beta:0.241981 gamma:-0.808451 main debug: using audio filter module "equalizer" main debug: TIMER module_need() : 0.310 ms - Total 0.310 ms / 1 intvls (Avg 0.310 ms) main debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.096 ms - Total 0.096 ms / 1 intvls (Avg 0.096 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.097 ms - Total 0.097 ms / 1 intvls (Avg 0.097 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 6 ms main warning: PTS is out of range (-9963), dropping buffer main debug: TIMER input launching for '02 - Halloween Boat.flac' : 14.878 ms - Total 14.878 ms / 1 intvls (Avg 14.878 ms) main warning: audio output out of sync, adjusting dates (-45947 us) main warning: not synchronized (-45947 us), resampling main warning: buffer too early (-46402), down-sampling main warning: resampling stopped after 19690582 usec (drift: -1081) main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1000 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 9% main debug: Buffering 18% main debug: Buffering 27% main debug: Buffering 37% main debug: Buffering 46% main debug: Buffering 55% main debug: Buffering 65% main debug: Buffering 74% main debug: Buffering 83% main debug: Buffering 92% main debug: Stream buffering done (1021 ms in 770 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82909), dropping buffer main warning: PTS is out of range (-9922), dropping buffer main debug: audio output is starving (-82213), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1148 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 8% main debug: Buffering 16% main debug: Buffering 24% main debug: Buffering 32% main debug: Buffering 40% main debug: Buffering 48% main debug: Buffering 56% main debug: Buffering 64% main debug: Buffering 72% main debug: Buffering 80% main debug: Buffering 88% main debug: Buffering 97% main debug: Stream buffering done (1207 ms in 457 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82898), dropping buffer main warning: PTS is out of range (-9926), dropping buffer main debug: audio output is starving (-72006), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1627 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 5% main debug: Buffering 11% main debug: Buffering 17% main debug: Buffering 22% main debug: Buffering 28% main debug: Buffering 34% main debug: Buffering 39% main debug: Buffering 45% main debug: Buffering 51% main debug: Buffering 57% main debug: Buffering 62% main debug: Buffering 68% main debug: Buffering 74% main debug: Buffering 79% main debug: Buffering 85% main debug: Buffering 91% main debug: Buffering 97% main debug: Stream buffering done (1671 ms in 547 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82891), dropping buffer main warning: PTS is out of range (-9957), dropping buffer main debug: audio output is starving (-81536), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1635 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 5% main debug: Buffering 11% main debug: Buffering 17% main debug: Buffering 22% main debug: Buffering 28% main debug: Buffering 34% main debug: Buffering 39% main debug: Buffering 45% main debug: Buffering 51% main debug: Buffering 56% main debug: Buffering 62% main debug: Buffering 68% main debug: Buffering 73% main debug: Buffering 79% main debug: Buffering 85% main debug: Buffering 90% main debug: Buffering 96% main debug: Stream buffering done (1671 ms in 1483 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82898), dropping buffer main warning: PTS is out of range (-9939), dropping buffer main debug: audio output is starving (-77884), playing silence main warning: audio output out of sync, adjusting dates (-43055 us) main warning: not synchronized (-43055 us), resampling main warning: buffer too early (-43056), down-sampling main warning: resampling stopped after 18296329 usec (drift: -913) main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 2138 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: Buffering 4% main debug: End of audio preroll main debug: Buffering 8% main debug: Buffering 13% main debug: Buffering 17% main debug: Buffering 21% main debug: Buffering 26% main debug: Buffering 30% main debug: Buffering 34% main debug: Buffering 39% main debug: Buffering 43% main debug: Buffering 47% main debug: Buffering 52% main debug: Buffering 56% main debug: Buffering 60% main debug: Buffering 65% main debug: Buffering 69% main debug: Buffering 73% main debug: Buffering 78% main debug: Buffering 82% main debug: Buffering 86% main debug: Buffering 91% main debug: Buffering 95% main debug: Buffering 99% main debug: Stream buffering done (2229 ms in 81 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82899), dropping buffer main warning: PTS is out of range (-9923), dropping buffer main debug: audio output is starving (-73054), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 2376 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 3% main debug: Buffering 7% main debug: Buffering 11% main debug: Buffering 15% main debug: Buffering 19% main debug: Buffering 23% main debug: Buffering 27% main debug: Buffering 31% main debug: Buffering 35% main debug: Buffering 39% main debug: Buffering 42% main debug: Buffering 46% main debug: Buffering 50% main debug: Buffering 54% main debug: Buffering 58% main debug: Buffering 62% main debug: Buffering 66% main debug: Buffering 70% main debug: Buffering 74% main debug: Buffering 78% main debug: Buffering 82% main debug: Buffering 85% main debug: Buffering 89% main debug: Buffering 93% main debug: Buffering 97% main debug: Stream buffering done (2414 ms in 411 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82903), dropping buffer main warning: PTS is out of range (-9923), dropping buffer main debug: audio output is starving (-82225), playing silence main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 2764 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 3% main debug: Buffering 6% main debug: Buffering 10% main debug: Buffering 13% main debug: Buffering 16% main debug: Buffering 20% main debug: Buffering 23% main debug: Buffering 26% main debug: Buffering 30% main debug: Buffering 33% main debug: Buffering 36% main debug: Buffering 40% main debug: Buffering 43% main debug: Buffering 47% main debug: Buffering 50% main debug: Buffering 53% main debug: Buffering 57% main debug: Buffering 60% main debug: Buffering 63% main debug: Buffering 67% main debug: Buffering 70% main debug: Buffering 73% main debug: Buffering 77% main debug: Buffering 80% main debug: Buffering 84% main debug: Buffering 87% main debug: Buffering 90% main debug: Buffering 94% main debug: Buffering 97% main debug: Stream buffering done (2786 ms in 513 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82897), dropping buffer main warning: PTS is out of range (-9936), dropping buffer main debug: audio output is starving (-78037), playing silence main warning: audio output out of sync, adjusting dates (-43206 us) main warning: not synchronized (-43206 us), resampling main warning: buffer too early (-43206), down-sampling main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 2781 ms) main error: ES_OUT_RESET_PCR called main debug: Buffering 0% main debug: End of audio preroll main debug: Buffering 3% main debug: Buffering 6% main debug: Buffering 10% main debug: Buffering 13% main debug: Buffering 16% main debug: Buffering 20% main debug: Buffering 23% main debug: Buffering 26% main debug: Buffering 30% main debug: Buffering 33% main debug: Buffering 36% main debug: Buffering 40% main debug: Buffering 43% main debug: Buffering 46% main debug: Buffering 50% main debug: Buffering 53% main debug: Buffering 56% main debug: Buffering 60% main debug: Buffering 63% main debug: Buffering 66% main debug: Buffering 70% main debug: Buffering 73% main debug: Buffering 76% main debug: Buffering 80% main debug: Buffering 83% main debug: Buffering 86% main debug: Buffering 90% main debug: Buffering 93% main debug: Buffering 96% main debug: Stream buffering done (2786 ms in 124 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (82920), dropping buffer main warning: PTS is out of range (-9918), dropping buffer main debug: audio output is starving (-72842), playing silence

[nkoriyama]

According to the logs, buffering happens frequently.

main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1627 ms)
main error: ES_OUT_RESET_PCR called
main debug: Buffering 0%

Increasing cache values (Preferences -> All -> Input/Codec file cache) may help.

[juan.vesa]

According to the logs, buffering happens frequently.

main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1627 ms)
main error: ES_OUT_RESET_PCR called
main debug: Buffering 0%

Increasing cache values (Preferences -> All -> Input/Codec file cache) may help.

hi, that seems to have fixed it, i ramped up all the cache levers to full (6000 ms), and it no longer cuts out, so i'll continue to monitor and report if anything else is problem.