Solved Slow movie playback initialization
#1
Question 
When I start playing a movie from my freenas box it takes a long time to buffer and play. I use a username and password to access the path, the username and password is the owner of the movies directory and can read/write/execute. I am not sure why there is so much slow buffering, it take like 20 seconds to start:

Code:
08:16:39 T:3053291392 M:1282838528  NOTICE: DVDPlayer: Opening: smb://FREENAS2/Movies/9 (2009).mkv
08:16:39 T:3053291392 M:1282838528 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
08:16:39 T:2860886896 M:1282711552   DEBUG: thread start, auto delete: 0
08:16:39 T:2860886896 M:1282711552  NOTICE: Creating InputStream
08:16:39 T:3053291392 M:1282711552   DEBUG: ------ Window Init (DialogBusy.xml) ------
08:16:40 T:2860886896 M:1281912832   DEBUG: CFileSMB::Open - opened Movies/9 (2009).mkv, fd=10000
08:16:40 T:2860886896 M:1281912832    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
08:16:40 T:2860886896 M:1281912832   DEBUG: CacheSubtitles: START
08:16:40 T:2860886896 M:1281912832   DEBUG: CacheSubtitles: Checking for common subdirs...
08:16:40 T:2860886896 M:1282039808   DEBUG: CacheSubtitles: Done (time: 300 ms)
08:16:40 T:2860886896 M:1282039808   DEBUG: CacheSubtitles: Searching for subtitles...
08:16:40 T:2860886896 M:1282039808   DEBUG: OpenDir - Using authentication url smb://user:password@FREENAS2/Movies
08:16:54 T:2963733360 M:1281671168   DEBUG: Thread 2963733360 terminating (autodelete)
08:16:54 T:2955340656 M:1281671168   DEBUG: Thread 2955340656 terminating (autodelete)
08:16:57 T:2860886896 M:1282232320   DEBUG: OpenDir - Using authentication url smb://user:password@FREENAS2/Movies/subtitles
08:16:59 T:2889755504 M:1281564672   DEBUG: Thread 2889755504 terminating (autodelete)
08:17:00 T:2860886896 M:1281953792   DEBUG: CacheSubtitles: Done (time: 19776 ms)
08:17:00 T:2860886896 M:1282080768   DEBUG: CacheSubtitles: END (total time: 20077 ms)
08:17:00 T:2860886896 M:1282080768    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
08:17:00 T:2860886896 M:1282080768  NOTICE: Creating Demuxer
08:17:00 T:2860886896 M:1282080768   DEBUG: Loading: /usr/lib/xbmc/system/players/dvdplayer/avformat-52-i486-linux.so
08:17:00 T:2860886896 M:1275383808   DEBUG: Open - probing detected format [matroska]
08:17:00 T:2860886896 M:1274241024   DEBUG: Open - av_find_stream_info starting
08:17:00 T:2860886896 M:1280540672   DEBUG: Open - av_find_stream_info finished
08:17:00 T:2860886896 M:1280540672    INFO: ffmpeg[AA85AB70]: Input #0, matroska, from 'smb://FREENAS2/Movies/9 (2009).mkv':
08:17:00 T:2860886896 M:1280540672    INFO: ffmpeg[AA85AB70]:   Duration: 01:19:11.52, start: 0.000000, bitrate: 2596 kb/s
08:17:00 T:2860886896 M:1280540672    INFO: ffmpeg[AA85AB70]:     Stream #0.0(eng): Video: h264, yuv420p, 1280x720, PAR 1:1 DAR 16:9, 23.98 fps, 24 tbr, 1k tbn, 47.95 tbc

If I try and play a movie in a freenas location that does not require a usename and password, playback starts almost immediately - both are 1080p files.

Code:
08:17:30 T:3053291392 M:1260253184  NOTICE: DVDPlayer: Opening: smb://FREENAS2/Transfer/Zombieland (2009).mkv
08:17:30 T:3053291392 M:1260253184 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
08:17:30 T:2955340656 M:1260126208   DEBUG: thread start, auto delete: 0
08:17:30 T:2955340656 M:1260126208  NOTICE: Creating InputStream
08:17:30 T:2955340656 M:1260072960   DEBUG: CFileSMB::Open - opened Transfer/Zombieland (2009).mkv, fd=10000
08:17:30 T:2955340656 M:1259900928    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
08:17:30 T:2955340656 M:1259900928   DEBUG: CacheSubtitles: START
08:17:30 T:2955340656 M:1259900928   DEBUG: CacheSubtitles: Checking for common subdirs...
08:17:30 T:3053291392 M:1257852928   DEBUG: ------ Window Init (DialogBusy.xml) ------
08:17:30 T:2955340656 M:1265598464   DEBUG: CacheSubtitles: Done (time: 210 ms)
08:17:30 T:2955340656 M:1265598464   DEBUG: CacheSubtitles: Searching for subtitles...
08:17:30 T:2955340656 M:1265598464   DEBUG: OpenDir - Using authentication url smb://macleod:february9th@FREENAS2/Transfer
08:17:30 T:2955340656 M:1263308800   DEBUG: CacheSubtitles: Done (time: 70 ms)
08:17:30 T:2955340656 M:1262673920   DEBUG: CacheSubtitles: END (total time: 282 ms)
08:17:30 T:2955340656 M:1262673920    INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
08:17:30 T:2955340656 M:1262673920  NOTICE: Creating Demuxer
08:17:30 T:2955340656 M:1257836544   DEBUG: Open - probing detected format [matroska]
08:17:30 T:2955340656 M:1265303552   DEBUG: Open - av_find_stream_info starting
08:17:30 T:2955340656 M:1258196992   DEBUG: Open - av_find_stream_info finished
08:17:30 T:2955340656 M:1258196992    INFO: ffmpeg[B026EB70]: Input #0, matroska, from 'smb://FREENAS2/Transfer/Zombieland (2009).mkv':
08:17:30 T:2955340656 M:1258070016    INFO: ffmpeg[B026EB70]:   Duration: 01:27:42.26, start: 0.000000, bitrate: 7137 kb/s
08:17:30 T:2955340656 M:1258070016    INFO: ffmpeg[B026EB70]:     Stream #0.0(eng): Video: h264, yuv420p, 1280x536, PAR 1:1 DAR 160:67, 23.98 fps, 24 tbr, 1k tbn, 47.95 tbc

Any ideas? I think I am going to change that subtitle file location - but I don't think that is it, because I tried Zombieland from the Movies directory and the Transfer directory - transfer was fine, movies (as usual) was slow.
Reply
#2
*bump* any ideas?
Reply
#3
please do not post snippets of your log files, post entire log to pastebin.
Proper Usage of a debug log
If I managed to help you in any way, please add to my reputation
Reply
#4
Ok, here is the full log:

http://pastebin.com/8pehEASR

I replaced my username with 'username', and password with 'password'. Let me know if you need anything else. I really think this is a permissions issue, but I really don't know what at this point.
Reply
#5
My issue was resolved by modifying my file structure - http://forum.xbmc.org/showthread.php?tid=187693
Reply

Logout Mark Read Team Forum Stats Members Help
Slow movie playback initialization0