.MKV files rewinds back to the beginning?

[Ghost.13]

Good day.

I downloaded torrent files for episodes of Sword Art Online.
The videos were in .mkv format, and I have already searched the entire forum, read related topics, applied possible solutions, but I still can't figure out how to stop the rewinding of the video from the very beginning.

The first video would last about 12 seconds before rewinding, and the rest lasts for about 7 seconds before rewinding.

Any news on this, as the articles I've read aren't that updated.

Thanks.

[TypX]

Update your vlc... this sounds like an ordered chapter issue which has been fixed since 2.0.0

[Ghost.13]

My VLC is up to date (should be 2.0.5).

That's why I'm asking if there is anything I could've missed.

[TypX]

Open VLC (just vlc not the video), open tools->messages, set verbosity to 2 then open the video, wait for the loop then paste the complete logs here or on the pastebin-like you want.

[Ghost.13]

Open VLC (just vlc not the video), open tools->messages, set verbosity to 2 then open the video, wait for the loop then paste the complete logs here or on the pastebin-like you want.

Here it is:

Code: Select all

main debug: adding item `[HorribleSubs] Sword Art Online - 01 [1080p].mkv' ( file:///C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv ) qt4 debug: Adding a new MRL to recent ones: file:///C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index -1 main debug: processing request item: [HorribleSubs] Sword Art Online - 01 [1080p].mkv, node: null, skip: 0 main debug: resyncing on [HorribleSubs] Sword Art Online - 01 [1080p].mkv main debug: [HorribleSubs] Sword Art Online - 01 [1080p].mkv is at 0 main debug: starting playback of the new playlist item main debug: resyncing on [HorribleSubs] Sword Art Online - 01 [1080p].mkv main debug: Creating an input for '[HorribleSubs] Sword Art Online - 01 [1080p].mkv' main debug: [HorribleSubs] Sword Art Online - 01 [1080p].mkv is at 0 main debug: creating new input thread main debug: Creating an input for '[HorribleSubs] Sword Art Online - 01 [1080p].mkv' main debug: using timeshift granularity of 50 MiB, in path 'C:\Users\Ghost\AppData\Local\Temp' main debug: `file:///C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv' gives access `file' demux `' path `/C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv' main debug: creating demux: access='file' demux='' location='/C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv' file='C:\Users\Ghost\Downloads\Sword Art Online\[HorribleSubs] Sword Art Online - 01 [1080p].mkv' 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() : 1.282 ms - Total 1.282 ms / 1 intvls (Avg 1.282 ms) main debug: creating access 'file' location='/C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv', path='C:\Users\Ghost\Downloads\Sword Art Online\[HorribleSubs] Sword Art Online - 01 [1080p].mkv' main debug: looking for access module: 3 candidates filesystem debug: opening file `C:\Users\Ghost\Downloads\Sword Art Online\[HorribleSubs] Sword Art Online - 01 [1080p].mkv' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.968 ms - Total 0.968 ms / 1 intvls (Avg 0.968 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 - 16129 KiB/s main debug: looking for stream_filter module: 4 candidates main debug: no stream_filter module matching "any" could be loaded main debug: TIMER module_need() : 0.244 ms - Total 0.244 ms / 1 intvls (Avg 0.244 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.234 ms - Total 0.234 ms / 1 intvls (Avg 0.234 ms) main debug: creating demux: access='file' demux='' location='/C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv' file='C:\Users\Ghost\Downloads\Sword Art Online\[HorribleSubs] Sword Art Online - 01 [1080p].mkv' main debug: looking for demux module: 55 candidates qt4 debug: IM: Setting an input mkv debug: | + Seek head mkv debug: | | + Seek mkv debug: | - info at 4151 mkv debug: | + Information mkv debug: | | + TimecodeScale=1000000 mkv debug: | | + Muxing Application=libebml v1.2.3 + libmatroska v1.3.0 mkv debug: | | + Writing Application=mkvmerge v5.2.0 ('I can't explain') built on Dec 18 2011 18:12:03 mkv debug: | | + Duration=1420155 mkv debug: | | + Date=Sat Jul 07 15:53:43 2012 mkv debug: | | + UID=-2047235690 mkv debug: | | + Seek mkv debug: | - tracks at 4307 mkv debug: | + Tracks mkv debug: | | + Track Entry mkv debug: | | | + Track Number=1 mkv debug: | | | + Track UID=3874838926 mkv debug: | | | + Track Type=video mkv debug: | | | + Track Forced=1 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track MinCache=1 mkv debug: | | | + Track CodecId=V_MPEG4/ISO/AVC mkv debug: | | | + Track CodecPrivate size=42 mkv debug: | | | + Track Default Duration=41999999 mkv debug: | | | + Track Language=`und' mkv debug: | | | + Track Video mkv debug: | | | | + width=1920 mkv debug: | | | | + height=1080 mkv debug: | | | | + display width=1920 mkv debug: | | | | + display height=1080 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=2 mkv debug: | | | + Track UID=3845915048 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track Forced=1 mkv debug: | | | + Track CodecId=A_AAC mkv debug: | | | + Track CodecPrivate size=2 mkv debug: | | | + Track Default Duration=23219954 mkv debug: | | | + Track Language=`und' mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=44100 mkv debug: | | | | + achan=2 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=3 mkv debug: | | | + Track UID=1662918077 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Forced=1 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/ASS mkv debug: | | | + Track CodecPrivate size=1865 mkv debug: | | | + Track Language=`und' mkv debug: | | + Seek mkv debug: | - cues at 567962585 mkv debug: | + Cues mkv debug: | - loading cues done. mkv debug: | | + Seek mkv debug: | | + Unknown (N7libebml8EbmlVoidE) mkv debug: | - attachments at 7513 mkv debug: | + Attachments mkv debug: | | - Commerce_Black_Condensed_SSi_Bold_Condensed.ttf (application/x-truetype-font) mkv debug: | + Void mkv debug: | + Information mkv debug: | + Tracks mkv debug: | + Void mkv debug: | + Attachments 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() : 192.077 ms - Total 192.077 ms / 1 intvls (Avg 192.077 ms) main debug: looking for a subtitle file in C:\Users\Ghost\Downloads\Sword Art Online\ main debug: looking for decoder module: 32 candidates main debug: meta ok for (null), need to fetch art main debug: looking for meta fetcher module: 1 candidate avcodec debug: libavcodec initialized (interface 0x361e00) lua debug: Trying Lua scripts in C:\Users\Ghost\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher avcodec debug: trying to use direct rendering avcodec debug: allowing 4 thread(s) for decoding lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started avcodec debug: using frame thread mode with 4 threads main debug: using decoder module "avcodec" main debug: TIMER module_need() : 548.454 ms - Total 548.454 ms / 1 intvls (Avg 548.454 ms) main debug: using meta fetcher module "lua" main debug: TIMER module_need() : 5.437 ms - Total 5.437 ms / 1 intvls (Avg 5.437 ms) main debug: removing module "lua" main debug: searching art for [HorribleSubs] Sword Art Online - 01 [1080p].mkv main debug: looking for art finder module: 2 candidates lua debug: Trying Lua scripts in C:\Users\Ghost\AppData\Roaming\vlc\lua\meta\art lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\art lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac main debug: no art finder module matching "any" could be loaded main debug: TIMER module_need() : 24.778 ms - Total 24.778 ms / 1 intvls (Avg 24.778 ms) main debug: art not found for [HorribleSubs] Sword Art Online - 01 [1080p].mkv main debug: looking for decoder module: 32 candidates main debug: using decoder module "faad" main debug: TIMER module_need() : 0.707 ms - Total 0.707 ms / 1 intvls (Avg 0.707 ms) main debug: looking for decoder module: 32 candidates libass debug: adding embedded font Commerce_Black_Condensed_SSi_Bold_Condensed.ttf main debug: using decoder module "libass" main debug: TIMER module_need() : 100.822 ms - Total 100.822 ms / 1 intvls (Avg 100.822 ms) main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in C:\Users\Ghost\AppData\Roaming\vlc\lua\meta\reader lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\reader lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\reader\filename.luac main debug: no meta reader module matching "any" could be loaded main debug: TIMER module_need() : 4.135 ms - Total 4.135 ms / 1 intvls (Avg 4.135 ms) main debug: `file:///C:/Users/Ghost/Downloads/Sword%20Art%20Online/%5BHorribleSubs%5D%20Sword%20Art%20Online%20-%2001%20%5B1080p%5D.mkv' successfully opened main debug: Buffering 0% main debug: Stream buffering done (334 ms in 0 ms) faad warning: decoded zero sample main debug: looking for text renderer module: 2 candidates freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 40.934 ms - Total 40.934 ms / 1 intvls (Avg 40.934 ms) main debug: looking for video filter2 module: 18 candidates swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality) main debug: using video filter2 module "swscale" main debug: TIMER module_need() : 56.534 ms - Total 56.534 ms / 1 intvls (Avg 56.534 ms) main debug: looking for video filter2 module: 18 candidates yuvp debug: YUVP to YUVA converter main debug: using video filter2 module "yuvp" main debug: TIMER module_need() : 131.904 ms - Total 131.904 ms / 1 intvls (Avg 131.904 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: 6 candidates direct3d debug: creating Vout EventThread direct3d debug: DirectXCreateWindow main debug: looking for vout window hwnd module: 2 candidates qt4 debug: requesting video... qt4 debug: Video was requested 0, 0 main debug: using vout window hwnd module "qt4" main debug: TIMER module_need() : 14.583 ms - Total 14.583 ms / 1 intvls (Avg 14.583 ms) direct3d debug: created video sub-window direct3d debug: Vout EventThread running direct3d debug: disabling screen saver direct3d debug: Direct3d Device: Intel(R) HD Graphics Family 32902 278 9 main debug: VoutDisplayEvent 'resize' 1936x1118 window direct3d warning: trying surface pixel format: YV12 direct3d debug: selected surface pixel format is YV12 direct3d debug: Using D3DTEXF_LINEAR for minification direct3d debug: Using D3DTEXF_LINEAR for magnification direct3d debug: Direct3D scene created successfully direct3d debug: Direct3D device adapter successfully initialized main debug: using vout display module "direct3d" main debug: TIMER module_need() : 394.328 ms - Total 394.328 ms / 1 intvls (Avg 394.328 ms) main debug: original format sz 1920x1080, of (0,0), vsz 1920x1080, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: VoutDisplayEvent 'resize' 1366x673 window main debug: removing module "freetype" main debug: looking for text renderer module: 2 candidates freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 2.023 ms - Total 2.023 ms / 1 intvls (Avg 2.023 ms) main debug: creating audio output avcodec debug: using direct rendering main debug: looking for audio output module: 2 candidates aout_directx debug: Opening DirectSound Audio Output main debug: End of video preroll main debug: Received first picture aout_directx debug: found device: Primary Sound Driver aout_directx debug: found device: Speakers / Headphones (IDT High Definition Audio CODEC) aout_directx debug: found device: Communications Headphones (IDT High Definition Audio CODEC) direct3d debug: Created 1467x71 texture for OSD main debug: Post-processing available aout_directx debug: device supports 2 channels (DEFAULT!) aout_directx debug: device supports 1 channel aout_directx debug: Windows says your SpeakerConfig is stereo aout_directx debug: creating DirectSoundThread main debug: using audio output module "aout_directx" main debug: TIMER module_need() : 188.234 ms - Total 188.234 ms / 1 intvls (Avg 188.234 ms) aout_directx debug: DirectSoundThread ready main debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 13 candidates audio_format debug: f32l->s16l, bits per sample: 32->16 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 127.796 ms - Total 127.796 ms / 1 intvls (Avg 127.796 ms) 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() : 7.955 ms - Total 7.955 ms / 1 intvls (Avg 7.955 ms) main debug: input 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 44100 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 8.246 ms - Total 8.246 ms / 1 intvls (Avg 8.246 ms) main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 13 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.356 ms - Total 0.356 ms / 1 intvls (Avg 0.356 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: Decoder buffering done in 968 ms main warning: PTS is out of range (-33203), dropping buffer main debug: picture might be displayed late (missing 3 ms) main debug: audio output is too slow (136873 us): trashing 50000 us main debug: audio output is too slow (86873 us): trashing 50000 us main debug: audio output is too slow (36873 us): trashing 50000 us main warning: audio output out of sync, adjusting dates (96856 us) main warning: not synchronized (96858 us), resampling main warning: buffer too late (95961), up-sampling main debug: auto hiding mouse cursor main debug: auto hiding mouse cursor direct3d debug: Created 743x75 texture for OSD main debug: auto hiding mouse cursor main debug: auto hiding mouse cursor main debug: picture might be displayed late (missing 9 ms) direct3d debug: Created 1039x74 texture for OSD main debug: picture might be displayed late (missing 1 ms) main warning: resampling stopped after 14097044 usec (drift: 1553) mkv warning: EOF mkv warning: cannot get block EOF? 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: finished input main debug: removing module "avcodec" avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) stopped main debug: killing decoder fourcc `h264', 0 PES in FIFO main debug: saving a free vout main debug: reusing provided vout main debug: removing module "faad" main debug: killing decoder fourcc `mp4a', 0 PES in FIFO main debug: removing module "scaletempo" main debug: removing module "samplerate" main debug: removing module "aout_directx" aout_directx debug: closing audio device aout_directx debug: DirectSoundThread exiting main debug: removing module "audio_format" main debug: removing module "float32_mixer" main debug: releasing audio output main debug: removing module "libass" main debug: killing decoder fourcc `ssa ', 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: changing item without a request (current 0/1) main debug: nothing to play main debug: destroying useless vout qt4 debug: IM: Deleting the input main debug: removing module "direct3d" direct3d debug: Direct3D scene released successfully main debug: TIMER input launching for '[HorribleSubs] Sword Art Online - 01 [1080p].mkv' : 882.936 ms - Total 882.936 ms / 1 intvls (Avg 882.936 ms) direct3d debug: DirectXEventThread terminating direct3d debug: DirectXCloseWindow direct3d debug: WinProc WM_DESTROY qt4 debug: releasing video... qt4 debug: Video is not needed anymore main debug: removing module "freetype" main debug: removing module "yuvp" main debug: removing module "swscale"

[TypX]

That's not a loop but an end of file, this sometimes happen when a file is corrupted and vlc doesn't handle it.
Could you try with a 2.0.6 nightly build on http://nightlies.videolan.org ? (Disregard the warning it's almost out) there have been improvement for that. If it doesn't work I'll get the file to debug but I'm still interested in the verbose logs for this version.

[Ghost.13]

That's not a loop but an end of file, this sometimes happen when a file is corrupted and vlc doesn't handle it.
Could you try with a 2.0.6 nightly build on http://nightlies.videolan.org ? (Disregard the warning it's almost out) there have been improvement for that. If it doesn't work I'll get the file to debug but I'm still interested in the verbose logs for this version.

That was great.
The nightly build played it smoothly (although I only played the first video, I'll let you all know what happens with the other videos).

I have a theory that it may be because the file is still downloading (haven't finished the full download yet), but nevertheless, the nightly build was awesome.

[TypX]

Ah then that's surely the case since torrents don't download pieces in order and vlc doesn't wait completeness to start playing.