Network speed - AngryFarmer - 2011-12-07
Hi everyone,
I have an issue with my XBMC setup on ATV2, it says "buffering" every time I'm watching a video. On some files it works fine, on some not. I have never had such a problem before. I've tested the LAN cable which comes to ATV2 using laptop and it gives me true 10mbytes per second (100mbps), I even tried to wget a binary file from a local web server (I don't know a way to copy file from a share using a telnet on ATV2, is there a way?), and it gives me 4.5mbytes per second average BUT, if I run XBMC (just run, no playback or something) and I repeat the wget of the same file the speed drops to 2.3mbytes per second.
Why is that? I don't think XBMC can transfer something in a background.
I've tried different builds and the problem still here, please help!
- block134 - 2011-12-07
Check this out to see if it helps http://wiki.xbmc.org/index.php?title=XBMC_for_iOS_specific_FAQ#Performance:_video_buffering.2C_stuttering.2C_choppiness
- Jester - 2011-12-07
AngryFarmer Wrote:Hi everyone,
I have an issue with my XBMC setup on ATV2, it says "buffering" every time I'm watching a video. On some files it works fine, on some not. I have never had such a problem before. I've tested the LAN cable which comes to ATV2 using laptop and it gives me true 10mbytes per second (100mbps), I even tried to wget a binary file from a local web server (I don't know a way to copy file from a share using a telnet on ATV2, is there a way?), and it gives me 4.5mbytes per second average BUT, if I run XBMC (just run, no playback or something) and I repeat the wget of the same file the speed drops to 2.3mbytes per second.
Why is that? I don't think XBMC can transfer something in a background.
I've tried different builds and the problem still here, please help!
http://wiki.xbmc.org/index.php?title=XBMC_for_iOS_specific_FAQ#Buffering
P.S.
for some file formats the ATV2 isn't powerful enough to process, so it buffers, try and stick with 720p h264 encode stuff and it works nicely
- AngryFarmer - 2011-12-07
* Update to the latest nightly build.
I have the latest build.
* Use a wired network connection
I do.
* Switch to a different network protocol (especially if you are using SMB), i.e. AFP, WebDAV, FTP or uPNP are good alternatives.
I have AFP on my WD World book II, but would I have to readd all my sources and ruin all my database?
* Try sharing the media on another device to rule out a device-specific (or network) issue.
Yes, all my videos are playing just fine on an Acer nettop from the same network source and same network segment.
* Configure Audio Output in XBMC > System > Settings > System to use Optical/Coax, even if you are using HDMI. If this fixes your buffering issue, please let us know on the forums.
Changed from HDMI to Digital, didn't help.
* Set to 16-bit audio, Apple TV > Settings > Audio & Video > Audio Output and set it to "16 bit".
I already had 16 bit option on, tried to set to automatic - didn't help.
* Turn off thumbnails, XBMC > Settings > Video > File and deselect 'generate thumbnails'.
Did it, no change.
* Disable playback sync completely, XBMC > Settings > Video > Playback > turn off "Sync playback to display".
Was off.
- DLeavy - 2011-12-07
To Jester's point, what type of file are you trying to play - it may just be too much for the Apple TV and not network related.
- AngryFarmer - 2011-12-07
BTW, here is a line from my log file:
Quote:00:18:16 T:213876736 NOTICE: Creating audio thread
00:18:16 T:219615232 NOTICE: running thread: CDVDPlayerAudio:rocess()
00:18:16 T:218124288 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 540
00:18:16 T:218124288 NOTICE: Display resolution DESKTOP : 1280x720 (12)
00:18:16 T:219615232 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec
00:18:16 T:219615232 NOTICE: Creating audio device with codec id: 86016, channels: 1, sample rate: 48000, no pass-through
00:18:17 T:177373184 NOTICE: Using GL_TEXTURE_2D
00:18:17 T:177373184 NOTICE: GL: Using software color conversion/RGBA render method
00:18:17 T:177373184 NOTICE: GL: NPOT texture support detected
00:18:19 T:219615232 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
Is it a network issue? Or it's an audio codec issue?
- AngryFarmer - 2011-12-07
The file information is:
Quote:Format : MPEG-PS
File size : 3.90 GiB
Duration : 1h 45mn
Overall bit rate : 5 308 Kbps
Video
ID : 224 (0xE0)
Format : MPEG Video
Format version : Version 2
Format profile : Main@main
Format settings, BVOP : Yes
Format settings, Matrix : Default
Duration : 1h 45mn
Bit rate mode : Variable
Bit rate : 5 050 Kbps
Width : 720 pixels
Height : 576 pixels
Display aspect ratio : 4:3
Frame rate : 25.000 fps
Standard : PAL
Color space : YUV
Chroma subsampling : 4:2:0
Bit depth : 8 bits
Scan type : Interlaced
Scan order : Top Field First
Compression mode : Lossy
Bits/(Pixel*Frame) : 0.487
Stream size : 3.68 GiB (94%)
Audio
ID : 192 (0xC0)
Format : MPEG Audio
Format version : Version 1
Format profile : Layer 2
Duration : 1h 45mn
Bit rate mode : Constant
Bit rate : 192 Kbps
Channel(s) : 1 channel
Sampling rate : 48.0 KHz
Compression mode : Lossy
Stream size : 144 MiB (4%)
- AngryFarmer - 2011-12-07
BUT !!! this file is playing just fine, it's even bigger than the first one!!!
Quote:Format : MPEG-PS
File size : 9.39 GiB
Duration : 4h 13mn
Overall bit rate : 5 309 Kbps
Video
ID : 224 (0xE0)
Format : MPEG Video
Format version : Version 2
Format profile : Main@main
Format settings, BVOP : Yes
Format settings, Matrix : Default
Duration : 4h 13mn
Bit rate mode : Variable
Bit rate : 5 050 Kbps
Width : 720 pixels
Height : 576 pixels
Display aspect ratio : 4:3
Frame rate : 25.000 fps
Standard : PAL
Color space : YUV
Chroma subsampling : 4:2:0
Bit depth : 8 bits
Scan type : Interlaced
Scan order : Top Field First
Compression mode : Lossy
Bits/(Pixel*Frame) : 0.487
Stream size : 8.86 GiB (94%)
Audio
ID : 192 (0xC0)
Format : MPEG Audio
Format version : Version 1
Format profile : Layer 2
Duration : 4h 13mn
Bit rate mode : Constant
Bit rate : 192 Kbps
Channel(s) : 1 channel
Sampling rate : 48.0 KHz
Compression mode : Lossy
Stream size : 348 MiB (4%)
- Berque - 2011-12-07
I am having the same issue on same device, the only difference is I can't use a wired connection.. Also it was speedy enough yesterday, and I dont know which settings did I change..
Btw, I hardly could create SMB connection. Which is the speediest connection and how can I create ?
Thanks..
- menno - 2011-12-07
I got also some buffering issues on a wired 1 gbit, atom debian d525 nas, which i never had before, see below for some xbmc.log
I cannot supply all logs right now, but since i read so much about it this might contribute
Code: 08:35:04 T:90337280 NOTICE: -----------------------------------------------------------------------
08:35:04 T:90337280 NOTICE: Starting XBMC, Platform: Darwin iOS (11.0.0 AppleTV2,1). Built on Dec 6 2011 (Git:20111206-109$
08:35:04 T:90337280 NOTICE: special://xbmc/ is mapped to: /private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome
08:35:04 T:90337280 NOTICE: special://xbmcbin/ is mapped to: /private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMC$
08:35:04 T:90337280 NOTICE: special://masterprofile/ is mapped to: /var/mobile/Library/Preferences/XBMC/userdata
08:35:04 T:90337280 NOTICE: special://home/ is mapped to: /var/mobile/Library/Preferences/XBMC
08:35:04 T:90337280 NOTICE: special://temp/ is mapped to: /var/mobile/Library/Preferences/XBMC/temp
08:35:04 T:90337280 NOTICE: special://frameworks/ is mapped to: /var/stash/Applications/XBMC.frappliance/Frameworks
08:35:04 T:90337280 NOTICE: The executable running is: /var/stash/Applications/XBMC.frappliance/XBMC
08:35:04 T:90337280 NOTICE: Log File is located: /var/mobile/Library/Preferences/xbmc.log
08:35:04 T:90337280 NOTICE: -----------------------------------------------------------------------
08:35:04 T:90337280 NOTICE: load settings...
08:35:04 T:90337280 NOTICE: special://profile/ is mapped to: special://masterprofile/
08:35:04 T:90337280 NOTICE: loading special://masterprofile/guisettings.xml
08:35:04 T:90337280 NOTICE: Getting hardware information now...
08:35:04 T:90337280 INFO: Using digital output
08:35:04 T:90337280 INFO: AC3 pass through is disabled
08:35:04 T:90337280 INFO: DTS pass through is disabled
08:35:04 T:90337280 INFO: AAC pass through is disabled
08:35:04 T:90337280 INFO: MP1 pass through is disabled
08:35:04 T:90337280 INFO: MP2 pass through is disabled
08:35:04 T:90337280 INFO: MP3 pass through is disabled
08:35:04 T:90337280 DEBUG: Error: Requested setting (videoscreen.screenmode) was not found. It must be case-sensitive
08:35:04 T:90337280 NOTICE: Checking resolution 12
08:35:04 T:90337280 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
08:35:04 T:90337280 DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
08:35:04 T:90337280 DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
08:35:04 T:90337280 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/rtmp/mms/udp
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: flv/aacp/sdp
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdfile
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdfile
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
08:35:04 T:90337280 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
08:35:04 T:90337280 NOTICE: Loaded playercorefactory configuration
08:35:04 T:90337280 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
08:35:04 T:90337280 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
08:35:04 T:90337280 NOTICE: No settings file to load to load (special://xbmc/system/advancedsettings.xml)
08:35:04 T:90337280 NOTICE: Loaded settings file from special://profile/advancedsettings.xml
08:35:04 T:90337280 NOTICE: Contents of special://profile/advancedsettings.xml are...
<advancedsettings>
<gui>
<algorithmdirtyregions>1</algorithmdirtyregions>
</gui>
</advancedsettings>
08:35:04 T:90337280 NOTICE: Getting hardware information now...
08:35:04 T:90337280 INFO: Using digital output
08:35:04 T:90337280 INFO: AC3 pass through is disabled
08:35:04 T:90337280 INFO: DTS pass through is disabled
08:35:04 T:90337280 INFO: AAC pass through is disabled
08:35:04 T:90337280 INFO: MP1 pass through is disabled
08:35:04 T:90337280 INFO: MP2 pass through is disabled
08:35:04 T:90337280 INFO: MP3 pass through is disabled
08:35:04 T:90337280 DEBUG: Error: Requested setting (videoscreen.screenmode) was not found. It must be case-sensitive
08:35:04 T:90337280 NOTICE: Checking resolution 12
08:35:04 T:90337280 NOTICE: Default DVD Player: dvdplayer
08:35:04 T:90337280 NOTICE: Default Video Player: dvdplayer
08:35:04 T:90337280 NOTICE: Default Audio Player: paplayer
08:35:04 T:90337280 NOTICE: Disabled debug logging due to GUI setting. Level 0.
08:35:04 T:90337280 NOTICE: Log level changed to 0
08:35:04 T:90337280 NOTICE: Loading media sources from special://masterprofile/sources.xml
08:35:04 T:90337280 NOTICE: GL_VENDOR = Imagination Technologies
08:35:04 T:90337280 NOTICE: GL_RENDERER = PowerVR SGX 535
08:35:04 T:90337280 NOTICE: GL_VERSION = OpenGL ES 2.0 IMGSGX535-58.6
08:35:04 T:90337280 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.0
08:35:04 T:90337280 NOTICE: GL_EXTENSIONS = GL_OES_depth_texture GL_OES_depth24 GL_OES_fbo_render_mipmap GL_OES_mapbuffer G$
08:35:05 T:90337280 NOTICE: initializing playlistplayer
08:35:05 T:90337280 NOTICE: DONE initializing playlistplayer
08:35:10 T:90337280 NOTICE: initialize done
08:35:05 T:90337280 NOTICE: DONE initializing playlistplayer
08:35:10 T:90337280 NOTICE: initialize done
08:35:10 T:90337280 NOTICE: Running the application...
08:35:10 T:90337280 NOTICE: Webserver: Starting...
08:35:10 T:106434560 NOTICE: -->Python Interpreter Initialized<--
08:35:10 T:90337280 NOTICE: WebServer: Started the webserver
08:35:10 T:90337280 NOTICE: starting upnp server
08:35:11 T:90337280 NOTICE: starting upnp renderer
08:35:11 T:90337280 NOTICE: ES: Starting event server
08:35:11 T:110424064 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
08:35:11 T:110424064 NOTICE: UDP: Listening on port 9777
08:35:11 T:90337280 NOTICE: starting zeroconf publishing
08:35:12 T:106434560 ERROR: Error Type: <type 'exceptions.ImportError'>
08:35:12 T:106434560 ERROR: Error Contents: No module named simplejson
08:35:12 T:106434560 ERROR: Traceback (most recent call last):
File "/private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome/addon$
import os, sys, urllib2, base64, socket, simplejson
ImportError: No module named simplejson
08:35:31 T:90337280 NOTICE: DVDPlayer: Opening: smb://PIMP-ASS-SERVER/DVD/The.Art.Of.Getting.By.2011.720p.BluRay.x264-Japhs$
08:35:31 T:90337280 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
08:35:31 T:159961088 NOTICE: Creating InputStream
08:35:31 T:159961088 NOTICE: Creating Demuxer
08:35:32 T:159961088 NOTICE: Opening video stream: 0 source: 256
08:35:32 T:159961088 NOTICE: Creating video codec with codec id: 28
08:35:32 T:159961088 NOTICE: Open - using avcC atom of size(41), ref_frames(5)
08:35:32 T:159961088 NOTICE: Creating video thread
08:35:32 T:176967680 NOTICE: running thread: video_thread
08:35:32 T:159961088 NOTICE: Opening audio stream: 1 source: 256
08:35:32 T:159961088 NOTICE: Finding audio codec for: 86020
08:35:32 T:159961088 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec
08:35:32 T:159961088 NOTICE: Creating audio thread
08:35:32 T:177500160 NOTICE: running thread: CDVDPlayerAudio::Process()
08:35:33 T:177500160 NOTICE: Creating audio device with codec id: 86020, channels: 6, sample rate: 48000, no pass-through
08:35:33 T:176967680 NOTICE: fps: 23.976024, pwidth: 1280, pheight: 535, dwidth: 1277, dheight: 535
08:35:33 T:176967680 NOTICE: Display resolution DESKTOP : 1280x720 (12)
08:35:33 T:90337280 NOTICE: Using GL_TEXTURE_2D
08:35:33 T:90337280 NOTICE: GL: Using CoreVideoRef RGBA render method
08:35:33 T:90337280 NOTICE: GL: NPOT texture support detected
08:35:33 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:33 T:90337280 NOTICE: GL: NPOT texture support detected
08:35:33 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:35 T:176967680 WARNING: Previous line repeats 5 times.
- menno - 2011-12-07
and than it goes on
Code: 08:35:33 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:35 T:176967680 WARNING: Previous line repeats 5 times.
08:35:35 T:176967680 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
08:35:36 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:37 T:176967680 WARNING: Previous line repeats 8 times.
08:35:37 T:176967680 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
08:35:37 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:39 T:176967680 WARNING: Previous line repeats 13 times.
08:35:39 T:176967680 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
08:35:40 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:41 T:112660480 WARNING: Previous line repeats 7 times.
08:35:41 T:112660480 WARNING: FillBuffer: curl failed with code 6
08:35:41 T:112660480 ERROR: CFileCurl::CReadState::Open, didn't get any data from stream.
08:35:41 T:112660480 ERROR: Open - failed to open source <http://mirrors.xbmc.org/addons/eden-pre/addons.xml.md5>
08:35:41 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:41 T:805048320 WARNING: FillBuffer: curl failed with code 6
08:35:41 T:805048320 ERROR: CFileCurl::CReadState::Open, didn't get any data from stream.
08:35:41 T:805048320 ERROR: Timeout whilst retrieving http://feeds.feedburner.com/xbmc
08:35:41 T:176967680 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
08:35:41 T:177500160 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
08:35:43 T:176967680 WARNING: Previous line repeats 15 times.
- AngryFarmer - 2011-12-08
We all have the same problem:
CDVDMessageQueue(audio/video)::Get - asked for new data packet, with nothing available
- davilla - 2011-12-08
There are two ways to get the dreaded "::Get - asked for new data packet, with nothing available".
1) Poor network speeds. Nuf said.
2) Trying to play something the atv2 cannot handle.
This one can mask as 1) but it's really easy to see in xbmc.log. If ffmpeg is used for software decode and you think it is 1), then it's most likely 2).
The internal player is trying to keep a/v in sync, it can't and then tried to skip ahead, that drains the demuxer queues and they need to be filled. When that does not happen in time... "::Get - asked for new data packet, with nothing available". Even if you look at 'top', CPU usage 'looks' ok but that's only because the internal player is thrashing about and not spending much time actually doing decode.
- canadave - 2011-12-08
Just out of curiosity, as an aside--is there a trick to running "top" on an ATV2? I just tried it, and got "command not found."
- AngryFarmer - 2011-12-08
canadave Wrote:Just out of curiosity, as an aside--is there a trick to running "top" on an ATV2? I just tried it, and got "command not found."
Works fine for me, Apple TV process consumes 50-60% cpu even without XBMC running ;-(
|