1. main debug: VLC media player - 3.0.21 Vetinari
2. main debug: Copyright © 1996-2024 the VideoLAN team
3. main debug: revision 3.0.21-0-gdd8bfdbabe
4. main debug: configured with /Users/d-fu/vlc-3.0/extras/package/macosx/../../../configure  '--prefix=/Users/d-fu/vlc-3.0/build-arm64/vlc_install_dir' '--enable-macosx' '--enable-merge-ffmpeg' '--enable-osx-notifications' '--enable-faad' '--enable-flac' '--enable-theora' '--enable-shout' '--enable-ncurses' '--enable-twolame' '--enable-realrtsp' '--enable-libass' '--enable-macosx-avfoundation' '--disable-skins2' '--disable-xcb' '--disable-caca' '--disable-pulse' '--disable-sdl-image' '--disable-vnc' '--build=x86_64-apple-darwin19' '--host=aarch64-apple-darwin19' '--with-macosx-version-min=10.7' '--with-macosx-sdk=/Applications/Xcode.app/Contents/Developer/Platforms/MacOSX.platform/Developer/SDKs/MacOSX.sdk' '--with-breakpad=https://mac.crashes.videolan.org' 'build_alias=x86_64-apple-darwin19' 'host_alias=aarch64-apple-darwin19' 'CC=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang' 'CFLAGS=-g -arch arm64' 'LDFLAGS=-arch arm64' 'CXX=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang++' 'CXXFLAGS=-g -arch arm64' 'OBJC=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang' 'OBJCFLAGS=-g -arch arm64'
5. main debug: Creating an input for preparsing 'bunny.m3u8'
6. main debug: incoming request - stopping current input
7. main debug: killing decoder fourcc `mp4a'
8. main debug: removing module "faad"
9. main debug: removing module "samplerate"
10. main debug: removing module "scaletempo"
11. auhal debug: Stopping the auhal module
12. main debug: removing module "float_mixer"
13. main debug: keeping audio output
14. main debug: removing module "adaptive"
15. main debug: removing module "mp4"
16. mp4 debug: freeing all memory
17. main debug: looking for meta fetcher module matching "any": 1 candidates
18. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/meta/fetcher
19. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/fetcher
20. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/fetcher
21. main debug: no meta fetcher modules matched
22. main debug: looking for art finder module matching "any": 2 candidates
23. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/meta/art
24. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/art
25. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/art
26. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
27. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
28. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
29. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
30. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
31. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
32. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
33. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
34. main debug: no art finder modules matched
35. main debug: Program doesn't contain anymore ES
36. main debug: removing module "record"
37. main debug: removing module "cache_read"
38. main debug: removing module "filesystem"
39. main debug: dead input
40. main debug: processing request item: bunny.m3u8, node: Playlist, skip: 0
41. main debug: rebuilding array of current - root Playlist
42. main debug: rebuild done - 4 items, index 3
43. main debug: starting playback of new item
44. main debug: resyncing on bunny.m3u8
45. main debug: bunny.m3u8 is at 3
46. main debug: creating new input thread
47. main debug: Creating an input for 'bunny.m3u8'
48. main debug: requesting art for new input thread
49. main debug: using timeshift granularity of 50 MiB
50. main debug: using default timeshift path
51. main debug: `file:///Users/christian/videos/bunny/bunny.m3u8' gives access `file' demux `any' path `/Users/christian/videos/bunny/bunny.m3u8'
52. main debug: looking for meta fetcher module matching "any": 1 candidates
53. main debug: creating demux: access='file' demux='any' location='/Users/christian/videos/bunny/bunny.m3u8' file='/Users/christian/videos/bunny/bunny.m3u8'
54. main debug: looking for access_demux module matching "file": 14 candidates
55. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/meta/fetcher
56. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/fetcher
57. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/fetcher
58. main debug: no meta fetcher modules matched
59. main debug: looking for art finder module matching "any": 2 candidates
60. main debug: no access_demux modules matched
61. main debug: creating access: file:///Users/christian/videos/bunny/bunny.m3u8
62. main debug:  (path: /Users/christian/videos/bunny/bunny.m3u8)
63. main debug: looking for access module matching "file": 24 candidates
64. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/meta/art
65. main debug: using access module "filesystem"
66. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/art
67. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
68. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/art
69. cache_read debug: Using stream method for AStream*
70. cache_read debug: starting pre-buffering
71. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
72. cache_read debug: received first data after 0 ms
73. cache_read debug: pre-buffering done 436 bytes in 0s - 11507 KiB/s
74. main debug: using stream_filter module "cache_read"
75. main debug: looking for stream_filter module matching "any": 26 candidates
76. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/playlist
77. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/playlist
78. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/playlist
79. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/anevia_streams.luac
80. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
81. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
82. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
83. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
84. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/anevia_xml.luac
85. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
86. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
87. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/appletrailers.luac
88. lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
89. main debug: no art finder modules matched
90. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/bbc_co_uk.luac
91. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/cue.luac
92. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/dailymotion.luac
93. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/jamendo.luac
94. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/koreus.luac
95. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/liveleak.luac
96. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/newgrounds.luac
97. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/rockbox_fm_presets.luac
98. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/soundcloud.luac
99. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/twitch.luac
100. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/vimeo.luac
101. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/vocaroo.luac
102. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/youtube.luac
103. main debug: no stream_filter modules matched
104. main debug: looking for stream_directory module matching "any": 1 candidates
105. main debug: no stream_directory modules matched
106. main debug: attachment of directory-extractor failed for file:///Users/christian/videos/bunny/bunny.m3u8
107. main debug: looking for stream_filter module matching "record": 26 candidates
108. main debug: using stream_filter module "record"
109. main debug: creating demux: access='file' demux='any' location='/Users/christian/videos/bunny/bunny.m3u8' file='/Users/christian/videos/bunny/bunny.m3u8'
110. main debug: looking for demux module matching "any": 55 candidates
111. adaptive debug: Period
112. adaptive debug:  BaseAdaptationSet group_audio audio_2
113. adaptive debug:   Representation a128k.m3u8 [mp4a.40.2]
114. adaptive debug:     (not loaded) Unknown
115. adaptive debug:   Representation v480.m3u8 [avc1.64001f]
116. adaptive debug:     (not loaded) Unknown
117. adaptive debug:   Representation v720.m3u8 [avc1.640020]
118. adaptive debug:     (not loaded) Unknown
119. main debug: selecting program id=0
120. adaptive debug: playlist Start/End 0/0 len 0rap pl/demux (0/0)
121. adaptive debug: cached.i_time (0) cur 0 rap start (pl 0/dmx 0) pos 0.000000
122. adaptive debug: opening playlist file (/Users/christian/videos/bunny/bunny.m3u8)
123. main debug: using demux module "adaptive"
124. main debug: looking for a subtitle file in /Users/christian/videos/bunny/
125. main debug: looking for audio decoder module matching "any": 21 candidates
126. main debug: using audio decoder module "faad"
127. main debug: looking for meta reader module matching "any": 2 candidates
128. lua debug: Trying Lua scripts in /Users/christian/Library/Application Support/org.videolan.vlc/lua/meta/reader
129. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/reader
130. lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader
131. lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader/filename.luac
132. main debug: no meta reader modules matched
133. main debug: `file:///Users/christian/videos/bunny/bunny.m3u8' successfully opened
134. adaptive debug: Retrieving file:///Users/christian/videos/bunny/a128k.m3u8 @0
135. main debug: creating access: file:///Users/christian/videos/bunny/a128k.m3u8
136. main debug:  (path: /Users/christian/videos/bunny/a128k.m3u8)
137. main debug: looking for access module matching "file": 24 candidates
138. main debug: using access module "filesystem"
139. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
140. cache_read debug: Using stream method for AStream*
141. cache_read debug: starting pre-buffering
142. cache_read debug: received first data after 0 ms
143. cache_read debug: pre-buffering done 1024 bytes in 0s - 66666 KiB/s
144. main debug: using stream_filter module "cache_read"
145. main debug: looking for stream_filter module matching "any": 26 candidates
146. main debug: no stream_filter modules matched
147. main debug: looking for stream_filter module matching "inflate": 26 candidates
148. main debug: no stream_filter modules matched
149. main debug: removing module "cache_read"
150. main debug: removing module "filesystem"
151. adaptive debug: Retrieving file:///Users/christian/videos/bunny/a128k.mp4 @0
152. main debug: creating access: file:///Users/christian/videos/bunny/a128k.mp4
153. main debug:  (path: /Users/christian/videos/bunny/a128k.mp4)
154. main debug: looking for access module matching "file": 24 candidates
155. main debug: using access module "filesystem"
156. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
157. cache_read debug: Using stream method for AStream*
158. cache_read debug: starting pre-buffering
159. cache_read debug: received first data after 0 ms
160. cache_read debug: pre-buffering done 1024 bytes in 0s - 40000 KiB/s
161. main debug: using stream_filter module "cache_read"
162. main debug: looking for stream_filter module matching "any": 26 candidates
163. main debug: no stream_filter modules matched
164. main debug: looking for stream_filter module matching "inflate": 26 candidates
165. main debug: no stream_filter modules matched
166. main debug: removing module "cache_read"
167. main debug: removing module "filesystem"
168. adaptive info: Changing stream format Unknown -> MP4
169. main debug: creating demux: access='' demux='mp4' location='' file='(null)'
170. main debug: looking for demux module matching "mp4": 55 candidates
171. adaptive debug: Retrieving file:///Users/christian/videos/bunny/a128k.mp4 @803
172. main debug: creating access: file:///Users/christian/videos/bunny/a128k.mp4
173. main debug:  (path: /Users/christian/videos/bunny/a128k.mp4)
174. main debug: looking for access module matching "file": 24 candidates
175. main debug: using access module "filesystem"
176. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
177. cache_read debug: Using stream method for AStream*
178. cache_read debug: starting pre-buffering
179. cache_read debug: received first data after 0 ms
180. cache_read debug: pre-buffering done 1024 bytes in 0s - 125000 KiB/s
181. main debug: using stream_filter module "cache_read"
182. main debug: looking for stream_filter module matching "any": 26 candidates
183. main debug: no stream_filter modules matched
184. main debug: looking for stream_filter module matching "inflate": 26 candidates
185. main debug: no stream_filter modules matched
186. main debug: removing module "cache_read"
187. main debug: removing module "filesystem"
188. mp4 debug: dumping root Box "root"
189. mp4 debug: |   + ftyp size 28 offset 0
190. mp4 debug: |   + moov size 775 offset 28
191. mp4 debug: |   |   + mvhd size 108 offset 36
192. mp4 debug: |   |   + trak size 521 offset 144
193. mp4 debug: |   |   |   + tkhd size 92 offset 152
194. mp4 debug: |   |   |   + edts size 48 offset 244
195. mp4 debug: |   |   |   |   + elst size 40 offset 252
196. mp4 debug: |   |   |   + mdia size 373 offset 292
197. mp4 debug: |   |   |   |   + mdhd size 32 offset 300
198. mp4 debug: |   |   |   |   + hdlr size 71 offset 332
199. mp4 debug: |   |   |   |   + minf size 262 offset 403
200. mp4 debug: |   |   |   |   |   + smhd size 16 offset 411
201. mp4 debug: |   |   |   |   |   + dinf size 36 offset 427
202. mp4 debug: |   |   |   |   |   |   + dref size 28 offset 435
203. mp4 debug: |   |   |   |   |   |   |   + url  size 12 offset 451
204. mp4 debug: |   |   |   |   |   + stbl size 202 offset 463
205. mp4 debug: |   |   |   |   |   |   + stsd size 126 offset 471
206. mp4 debug: |   |   |   |   |   |   |   + mp4a size 110 offset 487
207. mp4 debug: |   |   |   |   |   |   |   |   + esds size 54 offset 523
208. mp4 debug: |   |   |   |   |   |   |   |   + btrt size 20 offset 577
209. mp4 debug: |   |   |   |   |   |   + stts size 16 offset 597
210. mp4 debug: |   |   |   |   |   |   + stsc size 16 offset 613
211. mp4 debug: |   |   |   |   |   |   + stsz size 20 offset 629
212. mp4 debug: |   |   |   |   |   |   + stco size 16 offset 649
213. mp4 debug: |   |   + mvex size 40 offset 665
214. mp4 debug: |   |   |   + trex size 32 offset 673
215. mp4 debug: |   |   + udta size 98 offset 705
216. mp4 debug: |   |   |   + meta size 90 offset 713
217. mp4 debug: |   |   |   |   + hdlr size 33 offset 725
218. mp4 debug: |   |   |   |   + ilst size 45 offset 758
219. mp4 debug: |   |   |   |   |   + ctoo size 37 offset 766
220. mp4 debug: |   |   |   |   |   |   + data size 29 offset 774
221. mp4 debug: |   + sidx size 52 offset 803
222. mp4 debug: unrecognized major media specification (iso5).
223. mp4 debug: found 1 tracks
224. mp4 warning: elst box found
225. mp4 debug:    - [0] duration=12ms media time=-1ms) rate=1.0
226. mp4 debug:    - [1] duration=0ms media time=0ms) rate=1.0
227. mp4 warning: no chunk defined
228. mp4 debug: track[Id 0x1] read 0 chunk
229. mp4 warning: STTS table of 0 entries
230. mp4 debug: track[Id 0x1] read 0 samples length:0s
231. mp4 debug: adding track[Id 0x1] audio (enable) language undef
232. mp4 debug: Set Fragmented demux mode
233. main debug: using demux module "mp4"
234. mp4 debug: track 1 enabled!
235. mp4 info: Fragment sequence discontinuity detected 1 != 0
236. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.m3u8 @0
237. main debug: creating access: file:///Users/christian/videos/bunny/v720.m3u8
238. main debug:  (path: /Users/christian/videos/bunny/v720.m3u8)
239. main debug: looking for access module matching "file": 24 candidates
240. main debug: using access module "filesystem"
241. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
242. cache_read debug: Using stream method for AStream*
243. cache_read debug: starting pre-buffering
244. cache_read debug: received first data after 0 ms
245. cache_read debug: pre-buffering done 1024 bytes in 0s - 90909 KiB/s
246. main debug: using stream_filter module "cache_read"
247. main debug: looking for stream_filter module matching "any": 26 candidates
248. main debug: no stream_filter modules matched
249. main debug: looking for stream_filter module matching "inflate": 26 candidates
250. main debug: no stream_filter modules matched
251. main debug: removing module "cache_read"
252. main debug: removing module "filesystem"
253. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @0
254. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
255. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
256. main debug: looking for access module matching "file": 24 candidates
257. main debug: using access module "filesystem"
258. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
259. cache_read debug: Using stream method for AStream*
260. cache_read debug: starting pre-buffering
261. cache_read debug: received first data after 0 ms
262. cache_read debug: pre-buffering done 1024 bytes in 0s - 90909 KiB/s
263. main debug: using stream_filter module "cache_read"
264. main debug: looking for stream_filter module matching "any": 26 candidates
265. main debug: no stream_filter modules matched
266. main debug: looking for stream_filter module matching "inflate": 26 candidates
267. main debug: no stream_filter modules matched
268. main debug: removing module "cache_read"
269. main debug: removing module "filesystem"
270. adaptive info: Ending demuxer stream. [needrestart]
271. adaptive debug: Restarting demuxer 1 0
272. main debug: removing module "mp4"
273. mp4 debug: freeing all memory
274. main debug: killing decoder fourcc `mp4a'
275. main debug: removing module "faad"
276. main debug: looking for audio decoder module matching "any": 21 candidates
277. main debug: using audio decoder module "faad"
278. main debug: Buffering 0%
279. main debug: Buffering 2%
280. faad warning: decoded zero sample
281. main debug: Buffering 7%
282. main debug: Buffering 11%
283. main debug: reusing audio output
284. main debug: Buffering 15%
285. main debug: VLC is looking for: 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
286. main debug: Buffering 19%
287. auhal debug: attempting to use device 0
288. main debug: Buffering 24%
289. main debug: Buffering 28%
290. main debug: Buffering 32%
291. main debug: Buffering 36%
292. main debug: Buffering 41%
293. main debug: Buffering 45%
294. main debug: Buffering 49%
295. auhal debug: using default audio device 73
296. main debug: Buffering 54%
297. main debug: Buffering 58%
298. main debug: Buffering 62%
299. main debug: Buffering 66%
300. main debug: Buffering 71%
301. main debug: Buffering 75%
302. main debug: Buffering 79%
303. main debug: Buffering 83%
304. main debug: Buffering 88%
305. main debug: Buffering 92%
306. main debug: Buffering 96%
307. main debug: Stream buffering done (1009 ms in 0 ms)
308. auhal debug: Current device has a latency of 1458 us
309. auhal debug: output layout of AUHAL is Stereo
310. auhal debug: VLC will output: Stereo
311. auhal debug: Current AU format: [48000.000000][mcpl][9][8][1][8][2][32]
312. auhal debug: analog output successfully opened
313. main debug: output 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
314. main debug: looking for audio volume module matching "any": 2 candidates
315. main debug: using audio volume module "float_mixer"
316. main debug: input 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
317. main debug: looking for audio filter module matching "scaletempo": 16 candidates
318. scaletempo debug: format: 48000 rate, 2 nch, 4 bps, fl32
319. scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
320. scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode
321. main debug: using audio filter module "scaletempo"
322. main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
323. main debug: conversion pipeline complete
324. main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
325. main debug: conversion pipeline complete
326. main debug: looking for audio resampler module matching "any": 3 candidates
327. main debug: using audio resampler module "samplerate"
328. main debug: Decoder wait done in 3 ms
329. main debug: creating demux: access='' demux='mp4' location='' file='(null)'
330. main debug: looking for demux module matching "mp4": 55 candidates
331. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @869
332. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
333. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
334. main debug: looking for access module matching "file": 24 candidates
335. main debug: using access module "filesystem"
336. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
337. cache_read debug: Using stream method for AStream*
338. cache_read debug: starting pre-buffering
339. cache_read debug: received first data after 0 ms
340. cache_read debug: pre-buffering done 1024 bytes in 0s - 66666 KiB/s
341. main debug: using stream_filter module "cache_read"
342. main debug: looking for stream_filter module matching "any": 26 candidates
343. main debug: no stream_filter modules matched
344. main debug: looking for stream_filter module matching "inflate": 26 candidates
345. main debug: no stream_filter modules matched
346. mp4 debug: dumping root Box "root"
347. mp4 debug: |   + ftyp size 28 offset 0
348. mp4 debug: |   + moov size 841 offset 28
349. mp4 debug: |   |   + mvhd size 108 offset 36
350. mp4 debug: |   |   + trak size 587 offset 144
351. mp4 debug: |   |   |   + tkhd size 92 offset 152
352. mp4 debug: |   |   |   + edts size 48 offset 244
353. mp4 debug: |   |   |   |   + elst size 40 offset 252
354. mp4 debug: |   |   |   + mdia size 439 offset 292
355. mp4 debug: |   |   |   |   + mdhd size 32 offset 300
356. mp4 debug: |   |   |   |   + hdlr size 45 offset 332
357. mp4 debug: |   |   |   |   + minf size 354 offset 377
358. mp4 debug: |   |   |   |   |   + vmhd size 20 offset 385
359. mp4 debug: |   |   |   |   |   + dinf size 36 offset 405
360. mp4 debug: |   |   |   |   |   |   + dref size 28 offset 413
361. mp4 debug: |   |   |   |   |   |   |   + url  size 12 offset 429
362. mp4 debug: |   |   |   |   |   + stbl size 290 offset 441
363. mp4 debug: |   |   |   |   |   |   + stsd size 214 offset 449
364. mp4 debug: |   |   |   |   |   |   |   + avc1 size 198 offset 465
365. mp4 debug: |   |   |   |   |   |   |   |   + avcC size 57 offset 551
366. mp4 debug: |   |   |   |   |   |   |   |   + colr size 19 offset 608
367. mp4 debug: |   |   |   |   |   |   |   |   + pasp size 16 offset 627
368. mp4 debug: |   |   |   |   |   |   |   |   + btrt size 20 offset 643
369. mp4 debug: |   |   |   |   |   |   + stts size 16 offset 663
370. mp4 debug: |   |   |   |   |   |   + stsc size 16 offset 679
371. mp4 debug: |   |   |   |   |   |   + stsz size 20 offset 695
372. mp4 debug: |   |   |   |   |   |   + stco size 16 offset 715
373. mp4 debug: |   |   + mvex size 40 offset 731
374. mp4 debug: |   |   |   + trex size 32 offset 739
375. mp4 debug: |   |   + udta size 98 offset 771
376. mp4 debug: |   |   |   + meta size 90 offset 779
377. mp4 debug: |   |   |   |   + hdlr size 33 offset 791
378. mp4 debug: |   |   |   |   + ilst size 45 offset 824
379. mp4 debug: |   |   |   |   |   + ctoo size 37 offset 832
380. mp4 debug: |   |   |   |   |   |   + data size 29 offset 840
381. mp4 debug: |   + sidx size 52 offset 869
382. mp4 debug: unrecognized major media specification (iso5).
383. mp4 debug: found 1 tracks
384. mp4 warning: elst box found
385. mp4 debug:    - [0] duration=33ms media time=-1ms) rate=1.0
386. mp4 debug:    - [1] duration=0ms media time=33ms) rate=1.0
387. mp4 warning: no chunk defined
388. mp4 debug: track[Id 0x1] read 0 chunk
389. mp4 warning: STTS table of 0 entries
390. mp4 debug: track[Id 0x1] read 0 samples length:0s
391. mp4 debug: adding track[Id 0x1] video (enable) language undef
392. mp4 debug: Set Fragmented demux mode
393. main debug: using demux module "mp4"
394. mp4 debug: track 1 enabled!
395. mp4 info: Fragment sequence discontinuity detected 1 != 0
396. main debug: removing module "cache_read"
397. main debug: removing module "filesystem"
398. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @832002
399. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
400. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
401. main debug: looking for access module matching "file": 24 candidates
402. main debug: using access module "filesystem"
403. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
404. cache_read debug: Using stream method for AStream*
405. cache_read debug: starting pre-buffering
406. cache_read debug: received first data after 0 ms
407. cache_read debug: pre-buffering done 1024 bytes in 0s - 111111 KiB/s
408. main debug: using stream_filter module "cache_read"
409. main debug: looking for stream_filter module matching "any": 26 candidates
410. main debug: no stream_filter modules matched
411. main debug: looking for stream_filter module matching "inflate": 26 candidates
412. main debug: no stream_filter modules matched
413. main debug: removing module "cache_read"
414. main debug: removing module "filesystem"
415. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @4907801
416. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
417. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
418. main debug: looking for access module matching "file": 24 candidates
419. main debug: using access module "filesystem"
420. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
421. cache_read debug: Using stream method for AStream*
422. cache_read debug: starting pre-buffering
423. cache_read debug: received first data after 0 ms
424. cache_read debug: pre-buffering done 1024 bytes in 0s - 125000 KiB/s
425. main debug: using stream_filter module "cache_read"
426. main debug: looking for stream_filter module matching "any": 26 candidates
427. main debug: no stream_filter modules matched
428. main debug: looking for stream_filter module matching "inflate": 26 candidates
429. main debug: no stream_filter modules matched
430. main debug: removing module "cache_read"
431. main debug: removing module "filesystem"
432. macosx debug: Activated assertion NoIdleSleepAssertion through IOKit (36211)
433. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @6958032
434. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
435. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
436. main debug: looking for access module matching "file": 24 candidates
437. main debug: using access module "filesystem"
438. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
439. cache_read debug: Using stream method for AStream*
440. cache_read debug: starting pre-buffering
441. cache_read debug: received first data after 0 ms
442. cache_read debug: pre-buffering done 1024 bytes in 0s - 83333 KiB/s
443. main debug: using stream_filter module "cache_read"
444. main debug: looking for stream_filter module matching "any": 26 candidates
445. main debug: no stream_filter modules matched
446. main debug: looking for stream_filter module matching "inflate": 26 candidates
447. main debug: no stream_filter modules matched
448. main debug: removing module "cache_read"
449. main debug: removing module "filesystem"
450. macosx debug: Continue to use IOKit assertion NoIdleSleepAssertion (36211)
451. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @8188285
452. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
453. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
454. main debug: looking for access module matching "file": 24 candidates
455. main debug: using access module "filesystem"
456. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
457. cache_read debug: Using stream method for AStream*
458. cache_read debug: starting pre-buffering
459. cache_read debug: received first data after 0 ms
460. cache_read debug: pre-buffering done 1024 bytes in 0s - 31250 KiB/s
461. main debug: using stream_filter module "cache_read"
462. main debug: looking for stream_filter module matching "any": 26 candidates
463. main debug: no stream_filter modules matched
464. main debug: looking for stream_filter module matching "inflate": 26 candidates
465. main debug: no stream_filter modules matched
466. main debug: removing module "cache_read"
467. main debug: removing module "filesystem"
468. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @10157924
469. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
470. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
471. main debug: looking for access module matching "file": 24 candidates
472. main debug: using access module "filesystem"
473. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
474. cache_read debug: Using stream method for AStream*
475. cache_read debug: starting pre-buffering
476. cache_read debug: received first data after 0 ms
477. cache_read debug: pre-buffering done 1024 bytes in 0s - 20408 KiB/s
478. main debug: using stream_filter module "cache_read"
479. main debug: looking for stream_filter module matching "any": 26 candidates
480. main debug: no stream_filter modules matched
481. main debug: looking for stream_filter module matching "inflate": 26 candidates
482. main debug: no stream_filter modules matched
483. main debug: removing module "cache_read"
484. main debug: removing module "filesystem"
485. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @10546479
486. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
487. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
488. main debug: looking for access module matching "file": 24 candidates
489. main debug: using access module "filesystem"
490. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
491. cache_read debug: Using stream method for AStream*
492. cache_read debug: starting pre-buffering
493. cache_read debug: received first data after 0 ms
494. cache_read debug: pre-buffering done 1024 bytes in 0s - 27027 KiB/s
495. main debug: using stream_filter module "cache_read"
496. main debug: looking for stream_filter module matching "any": 26 candidates
497. main debug: no stream_filter modules matched
498. main debug: looking for stream_filter module matching "inflate": 26 candidates
499. main debug: no stream_filter modules matched
500. main debug: removing module "cache_read"
501. main debug: removing module "filesystem"
502. main debug: looking for video decoder module matching "any": 17 candidates
503. videotoolbox debug: new SPS parsed: 0
504. videotoolbox debug: new PPS parsed: 0
505. videotoolbox warning: forcing CVPX format: 420v
506. videotoolbox info: Using Video Toolbox to decode 'h264'
507. main debug: using video decoder module "videotoolbox"
508. main debug: killing decoder fourcc `mp4a'
509. main debug: removing module "faad"
510. main debug: removing module "samplerate"
511. main debug: removing module "scaletempo"
512. auhal debug: Stopping the auhal module
513. main debug: removing module "float_mixer"
514. main debug: keeping audio output
515. videotoolbox info: vt cvpx chroma: 420v
516. main debug: looking for text renderer module matching "any": 3 candidates
517. main debug: using text renderer module "freetype"
518. main debug: looking for video converter module matching "any": 16 candidates
519. swscale debug: 32x32 (32x32) chroma: YUVA -> 16x16 (16x16) chroma: RGBA with scaling using Bicubic (good quality)
520. main debug: using video converter module "swscale"
521. main debug: looking for video converter module matching "any": 16 candidates
522. yuvp debug: YUVP to YUVA converter
523. main debug: using video converter module "yuvp"
524. main debug: Deinterlacing available
525. main debug: deinterlace -1, mode auto, is_needed 0
526. main debug: looking for vout window module matching "any": 1 candidates
527. macosx debug: Opening video window
528. macosx debug: Releasing old IOKit other assertion (36211)
529. macosx debug: Activated assertion NoDisplaySleepAssertion through IOKit (36212)
530. macosx debug: toggle playlist from state: removed splitview 0, minimized view 0. Event 2
531. macosx debug: toggle playlist to state: removed splitview 0, minimized view 0
532. macosx debug: returning videoview with proposed position x=0, y=0, width=960, height=720
533. main debug: using vout window module "macosx"
534. main debug: Opening vout display wrapper
535. main debug: looking for vout display module matching "any": 7 candidates
536. main debug: VoutDisplayEvent 'resize' 960x720
537. main debug: VoutDisplayEvent 'resize' 0x0
538. main debug: VoutDisplayEvent 'resize' 3024x1760
539. main debug: looking for glconv module matching "any": 1 candidates
540. main debug: using glconv module "glconv_cvpx"
541. main debug: using vout display module "caopengllayer"
542. main debug: original format sz 960x720, of (0,0), vsz 960x720, 4cc CVPN, sar 1:1, msk r0x0 g0x0 b0x0
543. main debug: removing module "freetype"
544. main debug: looking for text renderer module matching "any": 3 candidates
545. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @10915857
546. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
547. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
548. main debug: looking for access module matching "file": 24 candidates
549. main debug: using access module "filesystem"
550. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
551. cache_read debug: Using stream method for AStream*
552. cache_read debug: starting pre-buffering
553. cache_read debug: received first data after 0 ms
554. cache_read debug: pre-buffering done 1024 bytes in 0s - 45454 KiB/s
555. main debug: using stream_filter module "cache_read"
556. main debug: looking for stream_filter module matching "any": 26 candidates
557. main debug: no stream_filter modules matched
558. main debug: looking for stream_filter module matching "inflate": 26 candidates
559. main debug: no stream_filter modules matched
560. main debug: removing module "cache_read"
561. main debug: removing module "filesystem"
562. adaptive debug: playlist Start/End 0/634566704 len 634566704rap pl/demux (42667/42667)
563. adaptive debug: cached.i_time (2133334) cur 2133334 rap start (pl 42667/dmx 42667) pos 0.003361
564. main debug: using text renderer module "freetype"
565. main warning: picture is too late to be displayed (missing 907 ms)
566. main warning: picture is too late to be displayed (missing 892 ms)
567. main warning: picture is too late to be displayed (missing 876 ms)
568. main warning: picture is too late to be displayed (missing 859 ms)
569. main warning: picture is too late to be displayed (missing 844 ms)
570. main warning: picture is too late to be displayed (missing 828 ms)
571. main warning: picture is too late to be displayed (missing 812 ms)
572. main warning: picture is too late to be displayed (missing 796 ms)
573. main warning: picture is too late to be displayed (missing 780 ms)
574. main warning: picture is too late to be displayed (missing 764 ms)
575. main warning: picture is too late to be displayed (missing 748 ms)
576. main warning: picture is too late to be displayed (missing 732 ms)
577. main warning: picture is too late to be displayed (missing 716 ms)
578. main warning: picture is too late to be displayed (missing 700 ms)
579. main warning: picture is too late to be displayed (missing 684 ms)
580. main warning: picture is too late to be displayed (missing 668 ms)
581. videotoolbox info: Raising max DPB to 3
582. main warning: picture is too late to be displayed (missing 653 ms)
583. main warning: picture is too late to be displayed (missing 637 ms)
584. main warning: picture is too late to be displayed (missing 621 ms)
585. main warning: picture is too late to be displayed (missing 604 ms)
586. main warning: picture is too late to be displayed (missing 588 ms)
587. main warning: picture is too late to be displayed (missing 572 ms)
588. main warning: picture is too late to be displayed (missing 556 ms)
589. main warning: picture is too late to be displayed (missing 540 ms)
590. main warning: picture is too late to be displayed (missing 524 ms)
591. main warning: picture is too late to be displayed (missing 508 ms)
592. main warning: picture is too late to be displayed (missing 492 ms)
593. main warning: picture is too late to be displayed (missing 476 ms)
594. main warning: picture is too late to be displayed (missing 460 ms)
595. main warning: picture is too late to be displayed (missing 444 ms)
596. main warning: picture is too late to be displayed (missing 428 ms)
597. main warning: picture is too late to be displayed (missing 412 ms)
598. main warning: picture is too late to be displayed (missing 396 ms)
599. main warning: picture is too late to be displayed (missing 380 ms)
600. main warning: picture is too late to be displayed (missing 364 ms)
601. main warning: picture is too late to be displayed (missing 347 ms)
602. main warning: picture is too late to be displayed (missing 331 ms)
603. main warning: picture is too late to be displayed (missing 315 ms)
604. main warning: picture is too late to be displayed (missing 299 ms)
605. main warning: picture is too late to be displayed (missing 283 ms)
606. main warning: picture is too late to be displayed (missing 267 ms)
607. main warning: picture is too late to be displayed (missing 251 ms)
608. main warning: picture is too late to be displayed (missing 235 ms)
609. main warning: picture is too late to be displayed (missing 219 ms)
610. main warning: picture is too late to be displayed (missing 203 ms)
611. main warning: picture is too late to be displayed (missing 187 ms)
612. main warning: picture is too late to be displayed (missing 171 ms)
613. main warning: picture is too late to be displayed (missing 155 ms)
614. main warning: picture is too late to be displayed (missing 139 ms)
615. main warning: picture is too late to be displayed (missing 123 ms)
616. main warning: picture is too late to be displayed (missing 107 ms)
617. main warning: picture is too late to be displayed (missing 91 ms)
618. main warning: picture is too late to be displayed (missing 74 ms)
619. main warning: picture is too late to be displayed (missing 58 ms)
620. main warning: picture is too late to be displayed (missing 42 ms)
621. main warning: picture is too late to be displayed (missing 26 ms)
622. main debug: picture might be displayed late (missing 10 ms)
623. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @13104942
624. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
625. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
626. main debug: looking for access module matching "file": 24 candidates
627. main debug: using access module "filesystem"
628. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
629. cache_read debug: Using stream method for AStream*
630. cache_read debug: starting pre-buffering
631. cache_read debug: received first data after 0 ms
632. cache_read debug: pre-buffering done 1024 bytes in 0s - 41666 KiB/s
633. main debug: using stream_filter module "cache_read"
634. main debug: looking for stream_filter module matching "any": 26 candidates
635. main debug: no stream_filter modules matched
636. main debug: looking for stream_filter module matching "inflate": 26 candidates
637. main debug: no stream_filter modules matched
638. main debug: removing module "cache_read"
639. main debug: removing module "filesystem"
640. main debug: VoutDisplayEvent 'resize' 1920x1440
641. main debug: VoutDisplayEvent 'resize' 1920x1440
642. adaptive debug: Retrieving file:///Users/christian/videos/bunny/v720.mp4 @14934249
643. main debug: creating access: file:///Users/christian/videos/bunny/v720.mp4
644. main debug:  (path: /Users/christian/videos/bunny/v720.mp4)
645. main debug: looking for access module matching "file": 24 candidates
646. main debug: using access module "filesystem"
647. main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
648. cache_read debug: Using stream method for AStream*
649. cache_read debug: starting pre-buffering
650. cache_read debug: received first data after 0 ms
651. cache_read debug: pre-buffering done 1024 bytes in 0s - 30303 KiB/s
652. main debug: using stream_filter module "cache_read"
653. main debug: looking for stream_filter module matching "any": 26 candidates
654. main debug: no stream_filter modules matched
655. main debug: looking for stream_filter module matching "inflate": 26 candidates
656. main debug: no stream_filter modules matched
657. main debug: removing module "cache_read"
658. main debug: removing module "filesystem"
659. adaptive debug: playlist Start/End 0/634566704 len 634566704rap pl/demux (42667/42667)
660. adaptive debug: cached.i_time (3133334) cur 3133334 rap start (pl 42667/dmx 42667) pos 0.004937
661. main debug: incoming request - stopping current input
662. main debug: killing decoder fourcc `h264'
663. main debug: removing module "videotoolbox"
664. main debug: saving a free vout
665. main debug: reusing provided vout
666. main debug: removing module "adaptive"
667. main debug: removing module "mp4"
668. mp4 debug: freeing all memory
669. main debug: Program doesn't contain anymore ES
670. main debug: removing module "record"
671. main debug: removing module "cache_read"
672. main debug: removing module "filesystem"
673. main debug: dead input
674. main debug: nothing to play
675. main debug: destroying useless vout
676. main debug: removing module "caopengllayer"
677. main debug: removing module "glconv_cvpx"
678. main debug: removing module "freetype"
679. main debug: removing module "yuvp"
680. main debug: removing module "swscale"
681. macosx debug: toggle playlist from state: removed splitview 0, minimized view 0. Event 2
682. macosx debug: toggle playlist to state: removed splitview 0, minimized view 0
683. macosx debug: Playback has been ended
684. macosx debug: Releasing IOKit monitor sleep blocker (36212)
685.