VLC 2.01 Audio drops every minute

macOS specific usage questions
calibrator
Blank Cone
Blank Cone
Posts: 10
Joined: 04 Mar 2011 13:38

VLC 2.01 Audio drops every minute

Postby calibrator » 25 Mar 2012 20:16

Hi I am very grateful for VLC player 2 and up because now my beamer is calibrated! This joyful event I wanted to celebrate by trying my old Mac mini on my beamer again however it almost works but not completely :(

The video looks smooth, no stutters however every minute or so the audio drops a fraction of a second.

I looked at the logs and I saw 'pts is out of range' very often in the log. Also some frames seemed to be late.

The specs of my Mini are late 2009 with nvidea 9400M and 2,26Ghz core 2 Duo.

Is this mini definitely out of range in performance or is there perhaps a fixs for this?

Thanx and again great work vlc 2 I am very very glad with it!!!!!!
Last edited by calibrator on 26 Mar 2012 20:56, edited 1 time in total.

calibrator
Blank Cone
Blank Cone
Posts: 10
Joined: 04 Mar 2011 13:38

Re: Audio drops every minute

Postby calibrator » 25 Mar 2012 20:33

I use Osx Lion and VLC 2.01. The problem does happen only when I use digital encoded audio out (dts / ac3) through s/pdif!

When I use not encoded stereo through s/pdif than there is no problem.

fkuehne
Developer
Developer
Posts: 7241
Joined: 16 Mar 2004 19:37
VLC version: 0.4.6 - present
Operating System: Darwin
Location: Germany
Contact:

Re: Audio drops every minute

Postby fkuehne » 25 Mar 2012 21:35

Strange to hear. What are your video sources? DVD? MKV? some other files?
VideoLAN
Felix Paul Kühne
Medic. VLC developer for appleOS since before you were born.
Blog: https://www.feepk.net

calibrator
Blank Cone
Blank Cone
Posts: 10
Joined: 04 Mar 2011 13:38

Re: Audio drops every minute

Postby calibrator » 25 Mar 2012 22:38

Hi it happens with every mkv that I try.

This log is from playing: the.secret.circle.S01E07.NLsubs.x264.WEB-DL-QoQ.mkv

A long log but I detected these lines in it:
main warning: PTS is out of range (-9966), dropping buffer
main debug: audio output is too slow (25342 us): trashing 32000 us


mkv debug: | | + Seek
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1235546036
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1236703547
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1237673022
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1238933310
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1240288605
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1241469648
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1242800731
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1244084111
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1245597748
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1247072271
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1248141413
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1249667680
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1251199413
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1252731208
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1254227798
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1255425663
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1256515181
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1257865223
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1258722139
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1259721468
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1260745895
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1261916659
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1263071387
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1264055205
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1265101906
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1265866701
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1265969329
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1266425555
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1267410172
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1268408341
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1269257500
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1269934601
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1270516333
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1271133543
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1271877405
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1272710386
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1273872857
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1275094987
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1276050535
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1276862038
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1277620250
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1278303607
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1279241852
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1280150386
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1280728392
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1281551216
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1282250056
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1283115389
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1283912967
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1285031143
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1285896545
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1286738150
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1287605666
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1288421805
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1289199297
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1289923762
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1290766246
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1291748962
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1292793624
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1293858184
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1294858626
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1295841562
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1296736943
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1297797991
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1298530427
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1299453592
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1300315668
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1301297807
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1301892177
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1302707474
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1303375435
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1304279811
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1305444976
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1306830801
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1308207557
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1309365137
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1310351076
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1311307249
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1312321684
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1313184463
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1314205609
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1315059321
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1316114899
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1317148648
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1318125108
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1319073440
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1320288689
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1321616697
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1322975237
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1324356996
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1325615886
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1326536484
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1327677467
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1328506019
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1329904069
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1331409481
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1332888504
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1334193684
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1335054649
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1336072907
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1336947310
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1337751713
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1338870904
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1339875999
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1340990931
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1342053433
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1343128833
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1344070376
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1345331917
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1346634188
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1347584059
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1348431050
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1349433706
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1350426227
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1351531747
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1352506620
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1353578201
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1354497373
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1355464055
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1356265158
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1357166303
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1357944274
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1359127538
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1360415634
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1361508899
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1362797549
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1364302651
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1365714170
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1366767328
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1367776220
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1368490215
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1369558086
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1370741426
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1371709267
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1372761127
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1374053084
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1375267226
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1376528398
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1377488451
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1378445753
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1379117056
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1379766326
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1380419520
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1380910898
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1381596871
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1382320596
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1383257116
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1384231878
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1385183949
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1386040648
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1386818331
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1387585668
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1388503726
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1390023315
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1391071010
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1392387485
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1393915068
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1394882784
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1395863905
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1396787027
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1397642840
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1398750719
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1400053708
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1401203033
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1402707653
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1404142608
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1405656128
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1407182184
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1408719330
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1410170890
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1411652966
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1412405883
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1412877546
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1413478988
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1414182673
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1414905563
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1415576950
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1415830584
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1415949130
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416066804
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416219379
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416335860
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416485586
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416611019
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416764430
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1416922372
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1417092141
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1417568283
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1419070944
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1420409278
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1421081271
mkv debug: | | + Seek
mkv debug: | - unknown seekhead reference at 1421197128
mkv debug: | | + Seek
mkv debug: | | + Unknown (N7libebml8EbmlVoidE)
mkv debug: | - cues at 1421256747
mkv debug: | + Cues
main debug: no fetch required for the secret circle S01E07 (art currently (null))
main debug: no fetch required for the secret circle S01E07 (art currently (null))
main debug: no fetch required for the secret circle S01E07 (art currently (null))
main debug: no fetch required for the secret circle S01E07 (art currently (null))
mkv debug: | - loading cues done.
mkv debug: | + Void
mkv debug: | + Information
mkv debug: | + Tracks
mkv debug: | + Void
mkv debug: | + Cluster
mkv debug: found 3 es
main debug: selecting program id=0
mkv debug: Starting the UI Hook
main debug: using demux module "mkv"
main debug: TIMER module_need() : 174.848 ms - Total 174.848 ms / 1 intvls (Avg 174.848 ms)
main debug: looking for a subtitle file in /Users/tvdb314/Downloads/circle s01e07/the.secret.circle.S01E07.NLsubs.x264.WEB-DL-QoQ
main debug: looking for decoder module: 31 candidates
avcodec debug: libavcodec initialized (interface 0x360a64)
avcodec debug: trying to use direct rendering
avcodec debug: allowing 3 thread(s) for decoding
avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started
avcodec debug: using frame thread mode with 3 threads
main debug: using decoder module "avcodec"
main debug: TIMER module_need() : 10.736 ms - Total 10.736 ms / 1 intvls (Avg 10.736 ms)
main debug: looking for decoder module: 31 candidates
main debug: using decoder module "a52"
main debug: TIMER module_need() : 0.267 ms - Total 0.267 ms / 1 intvls (Avg 0.267 ms)
main debug: looking for decoder module: 31 candidates
avcodec debug: libavcodec already initialized
avcodec debug: codec not found (Text subtitles with various tags)
subsdec debug: trying demuxer-specified character encoding: UTF-8
main debug: using decoder module "subsdec"
main debug: TIMER module_need() : 3.692 ms - Total 3.692 ms / 1 intvls (Avg 3.692 ms)
main debug: looking for meta reader module: 2 candidates
lua debug: Trying Lua scripts in /Users/tvdb314/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() : 0.834 ms - Total 0.834 ms / 1 intvls (Avg 0.834 ms)
main debug: `file:///Users/tvdb314/Downloads/circle%20s01e07/the.secret.circle.S01E07.NLsubs.x264.WEB-DL-QoQ/the.secret.circle.S01E07.NLsubs.x264.WEB-DL-QoQ.mkv' successfully opened
a52 debug: A/52 channels:6 samplerate:48000 bitrate:384000
main debug: creating audio output
main debug: Buffering 0%
main debug: looking for audio output module: 1 candidate
main debug: Buffering 33%
main debug: VLC is looking for: 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/1536 bytes
auhal debug: found 2 audio device(s)
main debug: looking for text renderer module: 3 candidates
main debug: Buffering 66%
main debug: Stream buffering done (1001 ms in 1 ms)
freetype debug: Building font databases.
auhal debug: DevID: 39 DevName: Ingebouwde ingang
auhal debug: this device is INPUT only. skipping...
auhal debug: DevID: 34 DevName: Ingebouwde uitgang
auhal debug: found 12 stream formats
auhal debug: supported format: [96000.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: [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: [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][3cac][76][6144][1536][0][2][16]
auhal debug: supported format: [48000.000000][3cac][76][6144][1536][0][2][16]
auhal debug: supported format: [44100.000000][3cac][76][6144][1536][0][2][16]
auhal debug: audio device supports digital output
auhal debug: original stream format: [48000.000000][mcpl][4][8][1][8][2][24]
auhal debug: setting stream format: [48000.000000][3cac][76][6144][1536][0][2][16]
freetype debug: Took 41225 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() : 44.291 ms - Total 44.291 ms / 1 intvls (Avg 44.291 ms)
main debug: looking for video filter2 module: 15 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() : 1.509 ms - Total 1.509 ms / 1 intvls (Avg 1.509 ms)
main debug: looking for video filter2 module: 15 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: TIMER module_need() : 2.758 ms - Total 2.758 ms / 1 intvls (Avg 2.758 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=1280, height=720
main debug: using vout window nsobject module "macosx"
main debug: TIMER module_need() : 0.438 ms - Total 0.438 ms / 1 intvls (Avg 0.438 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() : 49.399 ms - Total 49.399 ms / 1 intvls (Avg 49.399 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 9786 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() : 13.105 ms - Total 13.105 ms / 1 intvls (Avg 13.105 ms)
avcodec debug: using direct rendering
main debug: End of video preroll
main debug: Received first picture
main debug: Post-processing available
auhal debug: actual format in use: [48000.000000][3cac][76][6144][1536][0][2][16]
auhal debug: digital output successfully opened
main debug: using audio output module "auhal"
main debug: TIMER module_need() : 322.998 ms - Total 322.998 ms / 1 intvls (Avg 322.998 ms)
main debug: output 'spdi' 48000 Hz 3F2R/LFE frame=1536 samples/6144 bytes
main debug: mixer 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/6144 bytes
main debug: filter(s) 'a52 '->'spdi' 48000 Hz->48000 Hz 3F2R/LFE->3F2R/LFE
main debug: looking for audio filter module: 14 candidates
main debug: using audio filter module "a52tospdif"
main debug: TIMER module_need() : 2.922 ms - Total 2.922 ms / 1 intvls (Avg 2.922 ms)
main debug: conversion pipeline completed
main debug: looking for audio mixer module: 2 candidates
main debug: no audio mixer module matching "any" could be loaded
main debug: TIMER module_need() : 0.674 ms - Total 0.674 ms / 1 intvls (Avg 0.674 ms)
main debug: input 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/1536 bytes
main debug: filter(s) 'a52 '->'a52 ' 48000 Hz->48000 Hz 3F2R/LFE->3F2R/LFE
main debug: conversion pipeline completed
main debug: End of audio preroll
main debug: Decoder buffering done in 326 ms
main warning: PTS is out of range (-9966), dropping buffer
main debug: audio output is too slow (25342 us): trashing 32000 us
main debug: auto hiding mouse cursor
main debug: VoutDisplayEvent 'mouse button' 0 t=8
main debug: VoutDisplayEvent 'mouse button' 0 t=9
macosx debug: chosen screen isn't present, using current screen for fullscreen mode
main warning: picture is too late to be displayed (missing 21 ms)
main warning: picture is too late to be displayed (missing 89 ms)
main warning: picture is too late to be displayed (missing 48 ms)
main debug: picture might be displayed late (missing 6 ms)
main debug: picture might be displayed late (missing 14 ms)
main debug: looking for xml reader module: 1 candidate
main debug: using xml reader module "xml"
main debug: TIMER module_need() : 0.259 ms - Total 0.259 ms / 1 intvls (Avg 0.259 ms)
main warning: picture is too late to be displayed (missing 45 ms)
main debug: picture might be displayed late (missing 4 ms)
main debug: auto hiding mouse cursor
main warning: picture is too late to be displayed (missing 31 ms)
main debug: picture might be displayed late (missing 9 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 8 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 7 ms)
main debug: picture might be displayed late (missing 6 ms)
main warning: picture is too late to be displayed (missing 46 ms)
main debug: picture might be displayed late (missing 5 ms)
main debug: audio output is starving (-32116), playing silence
main debug: VoutDisplayEvent 'mouse button' 0 t=8
main debug: VoutDisplayEvent 'mouse button' 0 t=9
main debug: auto hiding mouse cursor
main debug: incoming request - stopping current input
main debug: dying input
main debug: control: stopping input
main debug: dying input
main warning: early picture skipped
main debug: removing module "avcodec"
avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) stopped
main debug: killing decoder fourcc `h264', 13 PES in FIFO
main debug: saving a free vout
main debug: reusing provided vout
main debug: removing module "a52"
main debug: killing decoder fourcc `a52 ', 0 PES in FIFO
main debug: removing module "auhal"
auhal debug: setting stream format: [48000.000000][mcpl][4][8][1][8][2][24]
auhal debug: actual format in use: [48000.000000][mcpl][4][8][1][8][2][24]
main debug: removing module "a52tospdif"
main debug: releasing audio output
main debug: removing module "subsdec"
main debug: killing decoder fourcc `subt', 0 PES in FIFO
main debug: removing module "mkv"
main debug: Program doesn't contain anymore ES
mkv debug: Stopping the UI Hook
main debug: removing module "stream_filter_record"
main debug: removing module "filesystem"
main debug: dead input
main debug: destroying useless vout
main debug: removing module "vout_macosx"
main debug: removing module "freetype"
main debug: removing module "yuvp"
main debug: removing module "swscale"

calibrator
Blank Cone
Blank Cone
Posts: 10
Joined: 04 Mar 2011 13:38

Re: Audio drops every minute

Postby calibrator » 26 Mar 2012 18:42

Short addition.

Playing an MKV video on my Macbook Pro 2011 2 GHz Intel Core i7 with Radeon HD 6490M I also experience audio drops but now once every half hour.

Again I'm using digital optical out to an external processor. I have no problems playing the MKV with iTunes but that is a lot of work ;)

alftheschnalf
New Cone
New Cone
Posts: 1
Joined: 29 May 2012 22:24

Re: VLC 2.01 Audio drops every minute

Postby alftheschnalf » 29 May 2012 22:32

Hi,

I too experience these issues (PTS is out of range & audio output is starving) when listening with my analogue headphones (no SPIF, just plain old laptop speakers). I'm using VLC 2.0.1 on OS X Lion 10.7.4.; right now I have these stutters while playing FLACs, but I may have heard them earlier today when listening to mp3s, too. Here's my log:

Code: Select all

auhal debug: supported format: [88200.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] main debug: Buffering 25% 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 29% main debug: Buffering 34% main debug: Buffering 38% main debug: Buffering 42% main debug: Buffering 46% auhal debug: current format is: [44100.000000][mcpl][41][4][1][4][2][32] main debug: Buffering 51% main debug: TIMER input launching for 'Variatio 14 a 2 Clav.' : 3.266 ms - Total 3.266 ms / 1 intvls (Avg 3.266 ms) main debug: Buffering 55% main debug: Buffering 59% auhal debug: layout of AUHAL has 2 channels auhal debug: selected 2 physical channels for device output main debug: Buffering 64% auhal debug: VLC will output: Stereo auhal debug: we set the AU format: [96000.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [96000.000000][mcpl][9][8][1][8][2][32] main debug: Buffering 68% main debug: Buffering 72% auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 10.712 ms - Total 10.712 ms / 1 intvls (Avg 10.712 ms) main debug: output 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: Buffering 76% main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 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.181 ms - Total 0.181 ms / 1 intvls (Avg 0.181 ms) main debug: input 's24l' 96000 Hz Stereo frame=1 samples/6 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 96000 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search main debug: Buffering 81% scaletempo debug: 1.000 scale, 2880.000 stride_in, 2880 stride_out, 2304 standing, 576 overlap, 1344 search, 4800 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.334 ms - Total 0.334 ms / 1 intvls (Avg 0.334 ms) main debug: filter(s) 's24l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s24l->f32l, bits per sample: 24->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.119 ms - Total 0.119 ms / 1 intvls (Avg 0.119 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 105600 Hz->96000 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.141 ms - Total 0.141 ms / 1 intvls (Avg 0.141 ms) main debug: conversion pipeline completed main debug: Buffering 85% main debug: End of audio preroll main debug: Buffering 89% main debug: Buffering 93% main debug: Buffering 98% main debug: Stream buffering done (1024 ms in 15 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (-9983), dropping buffer main debug: audio output is starving (-21504), playing silence main debug: audio output is starving (-21334), playing silence main debug: audio output is starving (-21339), playing silence main debug: audio output is starving (-21336), playing silence main debug: audio output is starving (-21357), playing silence main debug: audio output is starving (-21382), playing silence main debug: audio output is starving (-21372), playing silence 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: 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 17/23) main debug: using item 18 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'Variatio 15 a 1 Clav. Canone alla Quinta' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.flac' gives access `file' demux `' path `/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.flac' main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/16 Variatio 15 a 1 Clav. Canone alla Quinta.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.145 ms - Total 0.145 ms / 1 intvls (Avg 0.145 ms) main debug: creating access 'file' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.flac', path='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/16 Variatio 15 a 1 Clav. Canone alla Quinta.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/16 Variatio 15 a 1 Clav. Canone alla Quinta.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.121 ms - Total 0.121 ms / 1 intvls (Avg 0.121 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 - 16666 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.081 ms - Total 0.081 ms / 1 intvls (Avg 0.081 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.069 ms - Total 0.069 ms / 1 intvls (Avg 0.069 ms) main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/16 Variatio 15 a 1 Clav. Canone alla Quinta.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.075 ms - Total 0.075 ms / 1 intvls (Avg 0.075 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.238 ms - Total 0.238 ms / 1 intvls (Avg 0.238 ms) main debug: looking for a subtitle file in /Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka) main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 0.740 ms - Total 0.740 ms / 1 intvls (Avg 0.740 ms) main debug: removing module "taglib" main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/16%20Variatio%2015%20a%201%20Clav.%20Canone%20alla%20Quinta.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.172 ms - Total 0.172 ms / 1 intvls (Avg 0.172 ms) main debug: Buffering 0% flac debug: decode STREAMINFO flac debug: channels:2 samplerate:96000 bitspersamples:24 main debug: TIMER input launching for 'Variatio 14 a 2 Clav.' : 2.729 ms - Total 2.729 ms / 1 intvls (Avg 2.729 ms) flac debug: STREAMINFO decoded main debug: recycling audio output main debug: looking for audio output module: 1 candidate main debug: VLC is looking for: 's24l' 96000 Hz Stereo frame=1 samples/6 bytes auhal debug: found 2 audio device(s) auhal debug: DevID: 45 DevName: Eingang (integriert) auhal debug: this device is INPUT only. skipping... auhal debug: DevID: 34 DevName: Ausgang (integriert) 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: [96000.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [96000.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() : 7.235 ms - Total 7.235 ms / 1 intvls (Avg 7.235 ms) main debug: output 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 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.125 ms - Total 0.125 ms / 1 intvls (Avg 0.125 ms) main debug: input 's24l' 96000 Hz Stereo frame=1 samples/6 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 96000 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 2880.000 stride_in, 2880 stride_out, 2304 standing, 576 overlap, 1344 search, 4800 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.149 ms - Total 0.149 ms / 1 intvls (Avg 0.149 ms) main debug: filter(s) 's24l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s24l->f32l, bits per sample: 24->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.093 ms - Total 0.093 ms / 1 intvls (Avg 0.093 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 105600 Hz->96000 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.108 ms - Total 0.108 ms / 1 intvls (Avg 0.108 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Buffering 4% main debug: Buffering 8% main debug: Buffering 12% main debug: Buffering 17% main debug: Buffering 21% main debug: Buffering 25% main debug: Buffering 29% main debug: Buffering 34% main debug: Buffering 38% main debug: Buffering 42% main debug: Buffering 46% main debug: Buffering 51% main debug: Buffering 55% main debug: Buffering 59% main debug: Buffering 64% main debug: Buffering 68% main debug: Buffering 72% main debug: Buffering 76% main debug: Buffering 81% main debug: Buffering 85% main debug: Buffering 89% main debug: Buffering 93% main debug: Buffering 98% main debug: Stream buffering done (1024 ms in 68 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (-9983), dropping buffer main debug: audio output is starving (-21344), playing silence main debug: audio output is starving (-21370), playing silence main debug: audio output is starving (-21352), playing silence main debug: audio output is starving (-21363), playing silence main debug: audio output is starving (-21334), playing silence main debug: audio output is starving (-21354), playing silence main debug: audio output is starving (-21337), playing silence main debug: audio output is starving (-21339), playing silence main debug: audio output is starving (-21367), playing silence main debug: audio output is starving (-21347), playing silence main debug: audio output is starving (-21345), playing silence main debug: audio output is starving (-21351), playing silence main debug: audio output is starving (-21352), playing silence 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: 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 18/23) main debug: using item 19 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'Variatio 16 a 1 Clav. Ouverture' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.flac' gives access `file' demux `' path `/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.flac' main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/17 Variatio 16 a 1 Clav. Ouverture.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.313 ms - Total 0.313 ms / 1 intvls (Avg 0.313 ms) main debug: creating access 'file' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.flac', path='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/17 Variatio 16 a 1 Clav. Ouverture.flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/17 Variatio 16 a 1 Clav. Ouverture.flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.187 ms - Total 0.187 ms / 1 intvls (Avg 0.187 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 - 4566 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.143 ms - Total 0.143 ms / 1 intvls (Avg 0.143 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.119 ms - Total 0.119 ms / 1 intvls (Avg 0.119 ms) main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/17 Variatio 16 a 1 Clav. Ouverture.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.129 ms - Total 0.129 ms / 1 intvls (Avg 0.129 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.609 ms - Total 0.609 ms / 1 intvls (Avg 0.609 ms) main debug: looking for a subtitle file in /Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka) main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 19.537 ms - Total 19.537 ms / 1 intvls (Avg 19.537 ms) main debug: removing module "taglib" main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/17%20Variatio%2016%20a%201%20Clav.%20Ouverture.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.181 ms - Total 0.181 ms / 1 intvls (Avg 0.181 ms) main debug: Buffering 0% flac debug: decode STREAMINFO flac debug: channels:2 samplerate:96000 bitspersamples:24 flac debug: STREAMINFO decoded main debug: recycling audio output main debug: looking for audio output module: 1 candidate main debug: Buffering 4% main debug: VLC is looking for: 's24l' 96000 Hz Stereo frame=1 samples/6 bytes auhal debug: found 2 audio device(s) main debug: Buffering 8% main debug: Buffering 12% main debug: Buffering 17% main debug: Buffering 21% main debug: Buffering 25% main debug: Buffering 29% main debug: Buffering 34% main debug: Buffering 38% auhal debug: DevID: 45 DevName: Eingang (integriert) auhal debug: this device is INPUT only. skipping... main debug: Buffering 42% main debug: Buffering 46% auhal debug: DevID: 34 DevName: Ausgang (integriert) auhal debug: found 16 stream formats auhal debug: supported format: [96000.000000][mcpl][4][8][1][8][2][24] main debug: Buffering 51% 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] main debug: Buffering 55% 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] main debug: Buffering 59% 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 64% main debug: Buffering 68% main debug: Buffering 72% main debug: Buffering 76% main debug: Buffering 81% main debug: Buffering 85% main debug: Buffering 89% main debug: Buffering 93% auhal debug: current format is: [44100.000000][mcpl][41][4][1][4][2][32] main debug: Buffering 98% main debug: Stream buffering done (1024 ms in 8 ms) 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: [96000.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [96000.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() : 9.247 ms - Total 9.247 ms / 1 intvls (Avg 9.247 ms) main debug: output 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: mixer 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 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.145 ms - Total 0.145 ms / 1 intvls (Avg 0.145 ms) main debug: input 's24l' 96000 Hz Stereo frame=1 samples/6 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 96000 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 2880.000 stride_in, 2880 stride_out, 2304 standing, 576 overlap, 1344 search, 4800 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.163 ms - Total 0.163 ms / 1 intvls (Avg 0.163 ms) main debug: filter(s) 's24l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s24l->f32l, bits per sample: 24->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.094 ms - Total 0.094 ms / 1 intvls (Avg 0.094 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 105600 Hz->96000 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.096 ms - Total 0.096 ms / 1 intvls (Avg 0.096 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 3 ms main warning: PTS is out of range (-9987), dropping buffer main debug: TIMER input launching for 'Variatio 15 a 1 Clav. Canone alla Quinta' : 2.671 ms - Total 2.671 ms / 1 intvls (Avg 2.671 ms) main debug: audio output is starving (-21346), playing silence main debug: audio output is starving (-21350), playing silence main debug: audio output is starving (-21339), playing silence main debug: audio output is starving (-21369), playing silence main debug: audio output is starving (-21345), playing silence main debug: audio output is starving (-21333), playing silence main debug: audio output is starving (-21343), playing silence main debug: audio output is starving (-21336), playing silence main debug: audio output is starving (-21336), playing silence main debug: audio output is starving (-21334), playing silence main debug: audio output is starving (-21343), playing silence packetizer_flac debug: emulated sync word 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: 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 19/23) main debug: using item 20 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'Variatio 17 a 2 Clav.' main debug: using timeshift granularity of 50 MiB, in path '/tmp' main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..flac' gives access `file' demux `' path `/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..flac' main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/18 Variatio 17 a 2 Clav..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.216 ms - Total 0.216 ms / 1 intvls (Avg 0.216 ms) main debug: creating access 'file' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..flac', path='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/18 Variatio 17 a 2 Clav..flac' main debug: looking for access module: 3 candidates filesystem debug: opening file `/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/18 Variatio 17 a 2 Clav..flac' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.194 ms - Total 0.194 ms / 1 intvls (Avg 0.194 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 - 19607 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.108 ms - Total 0.108 ms / 1 intvls (Avg 0.108 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.120 ms - Total 0.120 ms / 1 intvls (Avg 0.120 ms) main debug: creating demux: access='file' demux='' location='/Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..flac' file='/Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka)/18 Variatio 17 a 2 Clav..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.140 ms - Total 0.140 ms / 1 intvls (Avg 0.140 ms) main debug: using demux module "flacsys" main debug: TIMER module_need() : 0.388 ms - Total 0.388 ms / 1 intvls (Avg 0.388 ms) main debug: looking for a subtitle file in /Users/***/Downloads/Open Goldberg Variations (Kimiko Ishizaka) main debug: looking for meta reader module: 2 candidates main debug: using meta reader module "taglib" main debug: TIMER module_need() : 0.530 ms - Total 0.530 ms / 1 intvls (Avg 0.530 ms) main debug: removing module "taglib" main debug: `file:///Users/***/Downloads/Open%20Goldberg%20Variations%20%28Kimiko%20Ishizaka%29/18%20Variatio%2017%20a%202%20Clav..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.223 ms - Total 0.223 ms / 1 intvls (Avg 0.223 ms) main debug: Buffering 0% flac debug: decode STREAMINFO flac debug: channels:2 samplerate:96000 bitspersamples:24 flac debug: STREAMINFO decoded main debug: TIMER input launching for 'Variatio 16 a 1 Clav. Ouverture' : 22.518 ms - Total 22.518 ms / 1 intvls (Avg 22.518 ms) main debug: recycling audio output main debug: looking for audio output module: 1 candidate main debug: VLC is looking for: 's24l' 96000 Hz Stereo frame=1 samples/6 bytes auhal debug: found 2 audio device(s) main debug: Buffering 4% main debug: Buffering 8% main debug: Buffering 12% main debug: Buffering 17% main debug: Buffering 21% auhal debug: DevID: 45 DevName: Eingang (integriert) auhal debug: this device is INPUT only. skipping... main debug: Buffering 25% auhal debug: DevID: 34 DevName: Ausgang (integriert) auhal debug: found 16 stream formats main debug: Buffering 29% 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 34% main debug: Buffering 38% main debug: Buffering 42% main debug: Buffering 46% main debug: Buffering 51% main debug: Buffering 55% auhal debug: current format is: [44100.000000][mcpl][41][4][1][4][2][32] main debug: Buffering 59% main debug: Buffering 64% 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: [96000.000000][mcpl][9][8][1][8][2][32] auhal debug: the actual set AU format is [96000.000000][mcpl][9][8][1][8][2][32] main debug: Buffering 68% main debug: Buffering 72% auhal debug: analog output successfully opened main debug: using audio output module "auhal" main debug: TIMER module_need() : 8.294 ms - Total 8.294 ms / 1 intvls (Avg 8.294 ms) main debug: output 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: Buffering 76% main debug: mixer 'f32l' 96000 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 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.165 ms - Total 0.165 ms / 1 intvls (Avg 0.165 ms) main debug: input 's24l' 96000 Hz Stereo frame=1 samples/6 bytes main debug: Buffering 81% main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 96000 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 2880.000 stride_in, 2880 stride_out, 2304 standing, 576 overlap, 1344 search, 4800 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 0.235 ms - Total 0.235 ms / 1 intvls (Avg 0.235 ms) main debug: filter(s) 's24l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: s24l->f32l, bits per sample: 24->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.139 ms - Total 0.139 ms / 1 intvls (Avg 0.139 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 96000 Hz->96000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 105600 Hz->96000 Hz Stereo->Stereo main debug: Buffering 85% main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.156 ms - Total 0.156 ms / 1 intvls (Avg 0.156 ms) main debug: conversion pipeline completed main debug: Buffering 89% main debug: End of audio preroll main debug: Buffering 93% main debug: Buffering 98% main debug: Stream buffering done (1024 ms in 11 ms) main debug: Decoder buffering done in 0 ms main warning: PTS is out of range (-9985), dropping buffer


Return to “VLC media player for macOS Troubleshooting”

Who is online

Users browsing this forum: No registered users and 22 guests