VLC UPNP not playing avi over 1GB

[jeyrey]

I have been streaming media using mediatomb on debian dockstar. Everything seems to be fine with the VLC player on MacOS except for avi over 1GB. Anyone has any idea what might cause the problem?

Note that the VLC player plays big avi files locally and it plays smaller avi files (less than 1GB) over UPNP.

[Jean-Baptiste Kempf]

Are they between 1GB and 2GB or over 2GB?

[jeyrey]

1.4gb. I also test with miniDLNA server, VLC still doesn't play big AVI.

[TypX]

Could you try to increase your http buffering? I've seen similar problems and it's often related to buffering and network perfomances.

[jeyrey]

Could you try to increase your http buffering? I've seen similar problems and it's often related to buffering and network perfomances.

Where do I do that in VLC Player?

[TypX]

* tools->preferences
* Show settings = all
* input/codecs->access modules->HTTP(S) then increase the HTTP caching value (try something like 5000)
* save
* restart vlc

[jeyrey]

I tried 5000 and 9000 and still does not work. The video window didn't even pop up at all. It just showed the length of the movie (in the console window) and then skipped to the new file and kept doing that until the file that is smaller than 1GB and the movie window popped up and played. Any idea?

[TypX]

When you increase the caching time you have to wait more, when you use 9000ms prepare to wait for at least 10 seconds (depending on the file you are trying to play).

[jeyrey]

Yes, I did wait until it skipped to the next file by itself.

[TypX]

Could you share some verbose logs then? (tools->message set verbosity to 2 and start playback)

[jeyrey]

Where do I find that on the menu? My Mac os vlcplayer doesn't have tools on the menu.

[TypX]

try ctrl+m

[jeyrey]

Here's what I got from the debug window. Note that the file I am trying to play is about 1.5GB.

Code: Select all

protocol 'HTTP' answer code 206 Content-Type: video/x-msvideo access_http debug: this frame size=1239881880 access_http debug: stream size=1505764782,pos=265882902,remaining=1239881880 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9756 entries access_http debug: trying to seek to 464721362 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=1041043420 access_http debug: stream size=1505764782,pos=464721362,remaining=1041043420 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9744 entries access_http debug: trying to seek to 644566148 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=861198634 access_http debug: stream size=1505764782,pos=644566148,remaining=861198634 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9751 entries access_http debug: trying to seek to 793079950 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=712684832 access_http debug: stream size=1505764782,pos=793079950,remaining=712684832 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9818 entries access_http debug: trying to seek to 913864696 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=591900086 access_http debug: stream size=1505764782,pos=913864696,remaining=591900086 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9747 entries access_http debug: trying to seek to 1050834452 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=454930330 access_http debug: stream size=1505764782,pos=1050834452,remaining=454930330 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 5987 entries access_http debug: trying to seek to 1108391868 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=397372914 access_http debug: stream size=1505764782,pos=1108391868,remaining=397372914 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 3819 entries access_http debug: trying to seek to 1349770856 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=155993926 access_http debug: stream size=1505764782,pos=1349770856,remaining=155993926 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 9729 entries access_http debug: trying to seek to 1505703798 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=60984 access_http debug: stream size=1505764782,pos=1505703798,remaining=60984 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 7619 entries avi warning: cannot find idx1 chunk, no index defined avi debug: selected ODML index for stream[0] avi debug: selected ODML index for stream[1] avi debug: stream[0] created 131705 index entries avi debug: stream[1] created 85831 index entries avi debug: stream[0] length:5493 (based on index) avi debug: stream[1] length:5493 (based on index) main debug: using demux module "avi" main debug: TIMER module_need() : 7746.369 ms - Total 7746.369 ms / 1 intvls (Avg 7746.369 ms) main debug: looking for decoder module: 32 candidates avcodec debug: libavcodec initialized (interface 0x350500) avcodec debug: trying to use direct rendering avcodec debug: ffmpeg codec (MPEG-4 Video) started main debug: using decoder module "avcodec" main debug: TIMER module_need() : 121.968 ms - Total 121.968 ms / 1 intvls (Avg 121.968 ms) main debug: thread (decoder) created at priority 0 (../../src/input/decoder.c:301) main debug: thread started main debug: looking for decoder module: 32 candidates main debug: using decoder module "a52" main debug: TIMER module_need() : 0.463 ms - Total 0.463 ms / 1 intvls (Avg 0.463 ms) main debug: thread (decoder) created at priority 22 (../../src/input/decoder.c:301) main debug: thread started main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in /Users/teeh/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 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.572 ms - Total 0.572 ms / 1 intvls (Avg 0.572 ms) main debug: `http://192.168.1.23:8200/MediaItems/205.avi' successfully opened main debug: Buffering 0% main debug: EOF reached main debug: Stream buffering done (0 ms in 0 ms) main debug: Decoder buffering done in 0 ms main debug: finished input main debug: waitpipe: object killed avcodec debug: ffmpeg codec (MPEG-4 Video) stopped main debug: removing module "avcodec" main debug: killing decoder fourcc `mp4v', 0 PES in FIFO main debug: removing module "a52" main debug: killing decoder fourcc `a52 ', 0 PES in FIFO avi warning: unknown chunk (not unloaded) main debug: removing module "avi" main debug: removing module "stream_filter_record" main debug: removing module "access_http" main debug: Program doesn't contain anymore ES main debug: thread ended main debug: dead input main debug: changing item without a request (current 170/184) main debug: using item 171 main debug: starting new item main debug: creating new input thread main debug: Creating an input for 'HarryPottertheDeathlyHallowsPart1' main debug: thread (input) created at priority 22 (../../src/input/input.c:220) main debug: thread started main debug: using timeshift granularity of 50 MiB main debug: using timeshift path '/tmp' main debug: `http://192.168.1.23:8200/MediaItems/18.avi' gives access `http' demux `' path `192.168.1.23:8200/MediaItems/18.avi' main debug: creating demux: access='http' demux='' path='192.168.1.23:8200/MediaItems/18.avi' main debug: looking for access_demux module: 0 candidates main debug: no access_demux module matched "http" main debug: TIMER module_need() : 0.211 ms - Total 0.211 ms / 1 intvls (Avg 0.211 ms) main debug: creating access 'http' path='192.168.1.23:8200/MediaItems/18.avi' main debug: looking for access module: 2 candidates access_http debug: http: server='192.168.1.23' port=8200 file='/MediaItems/18.avi' main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) macosx debug: input has stopped, refreshing interface main debug: TIMER input launching for '2012 Ice Age 2011 DVDRip Xvid AC3-Freebee' : 8027.684 ms - Total 8027.684 ms / 1 intvls (Avg 8027.683 ms) macosx debug: input has changed, refreshing interface access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=1251985666 access_http debug: stream size=1251985666,pos=0,remaining=1251985666 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 main debug: using access module "access_http" main debug: TIMER module_need() : 545.731 ms - Total 545.731 ms / 1 intvls (Avg 545.731 ms) main debug: Using AStream*Stream main debug: pre buffering main debug: received first data after 0 ms main debug: pre-buffering done 1024 bytes in 0s - 15873 KiB/s main debug: looking for stream_filter module: 5 candidates main debug: no stream_filter module matching "any" could be loaded main debug: TIMER module_need() : 0.272 ms - Total 0.272 ms / 1 intvls (Avg 0.272 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.143 ms - Total 0.143 ms / 1 intvls (Avg 0.143 ms) main debug: creating demux: access='http' demux='' path='192.168.1.23:8200/MediaItems/18.avi' main debug: looking for demux module: 52 candidates avi debug: <list 'AVI '> avi debug: <list 'hdrl'> avi debug: <list 'strl'> avi debug: </list 'strl'> avi debug: <list 'strl'> avi debug: </list 'strl'> avi debug: <list 'odml'> avi warning: unknown chunk (not loaded) avi debug: </list 'odml'> access_http debug: trying to seek to 65454 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=1251920212 access_http debug: stream size=1251985666,pos=65454,remaining=1251920212 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: </list 'hdrl'> avi debug: <list 'INFO'> avi debug: </list 'INFO'> avi debug: skipping movi chunk avi debug: </list 'AVI '> avi debug: * LIST-root size:1251985666 pos:0 avi debug: + RIFF-AVI size:1148100 pos:0 avi debug: | + LIST-hdrl size:65434 pos:12 avi debug: | | + avih size:56 pos:24 avi debug: | | + LIST-strl size:404 pos:88 avi debug: | | | + strh size:56 pos:100 avi debug: | | | + strf size:40 pos:164 avi debug: | | | + indx size:280 pos:212 avi debug: | | + LIST-strl size:416 pos:500 avi debug: | | | + strh size:56 pos:512 avi debug: | | | + strf size:30 pos:576 avi debug: | | | + strn size:14 pos:614 avi debug: | | | + indx size:280 pos:636 avi debug: | | + LIST-odml size:260 pos:924 avi debug: | | | + dmlh size:248 pos:936 avi debug: | | + JUNK size:64254 pos:1192 avi debug: | + LIST-INFO size:62 pos:65454 avi debug: | | + ISFT size:41 pos:65466 avi debug: | | + JUNK size:0 pos:65516 avi debug: | + LIST-movi size:1077544 pos:65524 avi debug: AVIH: 2 stream, flags HAS_INDEX IS_INTERLEAVED avi debug: stream[0] rate:10000000 scale:417083 samplesize:0 avi debug: stream[0] video(XVID) 640x272 12bpp 23.976044fps main debug: selecting program id=0 avi debug: stream[1] rate:24000 scale:1 samplesize:1 avi debug: stream[1] audio(0x55) 2 channels 48000Hz 0bits access_http debug: trying to seek to 1140500 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=1250845166 access_http debug: stream size=1251985666,pos=1140500,remaining=1250845166 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 299 entries access_http debug: trying to seek to 66139108 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) access_http debug: protocol 'HTTP' answer code 206 access_http debug: Content-Type: video/x-msvideo access_http debug: this frame size=1185846558 access_http debug: stream size=1251985666,pos=66139108,remaining=1185846558 access_http debug: Connection: close access_http debug: Server: Debian/6.0.2 DLNADOC/1.50 UPnP/1.0 MiniDLNA/1.0 avi debug: loading subindex(0x1) 14733 entries access_http debug: trying to seek to 155553056 main debug: net: connecting to 192.168.1.23 port 8200 main debug: connection succeeded (socket = 15) main debug: incoming request - stopping current input main debug: waitpipe: object killed main debug: dying input main debug: socket 15 polling interrupted access_http error: failed to read answer access_http error: seek failed access_http debug: trying to seek to 1144836 main debug: net: connecting to 192.168.1.23 port 8200 access_http error: cannot connect to 192.168.1.23:8200 access_http error: seek failed avi warning: cannot find idx1 chunk, no index defined avi debug: selected ODML index for stream[0] avi debug: selected standard index for stream[1] avi debug: stream[0] created 15032 index entries avi error: no key frame set for track 1 avi debug: stream[1] created 0 index entries avi debug: stream[0] length:626 (based on index) main debug: using demux module "avi" main debug: TIMER module_need() : 891.579 ms - Total 891.579 ms / 1 intvls (Avg 891.579 ms) main debug: looking for decoder module: 32 candidates avcodec debug: libavcodec already initialized avcodec debug: trying to use direct rendering avcodec debug: ffmpeg codec (MPEG-4 Video) started main debug: using decoder module "avcodec" main debug: TIMER module_need() : 1.151 ms - Total 1.151 ms / 1 intvls (Avg 1.151 ms) main debug: thread (decoder) created at priority 0 (../../src/input/decoder.c:301) main debug: thread started main debug: looking for decoder module: 32 candidates main debug: using decoder module "mpeg_audio" main debug: TIMER module_need() : 0.329 ms - Total 0.329 ms / 1 intvls (Avg 0.329 ms) main debug: thread (decoder) created at priority 22 (../../src/input/decoder.c:301) main debug: thread started main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in /Users/teeh/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 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.415 ms - Total 0.415 ms / 1 intvls (Avg 0.415 ms) main debug: `http://192.168.1.23:8200/MediaItems/18.avi' successfully opened main debug: dying input avcodec debug: ffmpeg codec (MPEG-4 Video) stopped main debug: removing module "avcodec" main debug: killing decoder fourcc `mp4v', 0 PES in FIFO main debug: removing module "mpeg_audio" main debug: killing decoder fourcc `mpga', 0 PES in FIFO avi warning: unknown chunk (not unloaded) main debug: removing module "avi" main debug: removing module "stream_filter_record" main debug: removing module "access_http" main debug: Program doesn't contain anymore ES main debug: thread ended main debug: dead input macosx debug: input has stopped, refreshing interface

[TypX]

main debug: net: connecting to 192.168.1.23 port 8200
access_http error: cannot connect to 192.168.1.23:8200

For some reasons your http server stops accepting requests at this address. You could try to increase the number of accepted clients on your UPnP server (or get a wireshark pcap file to see where the connection died).