This should get Pinned for the newcomers!
This should get Pinned for the newcomers!
Good call, Asphyx! This is an excellent write-up and it reminds me a lot of bhiga's "FAQ" thread on XDA. Oh, btw, I was gonna ask you earlier on the XDA Chromecast forum if you were AsphyxNYC on the PlexPass forums, but I got busy around the house and never got around to it. Good to see a name on here that I recognize from XDA and I know that when I read a post of yours that it's gonna be very accurate and informative! XDA needs a few more like you on there!
Good call, Asphyx! This is an excellent write-up and it reminds me a lot of bhiga's "FAQ" thread on XDA. Oh, btw, I was gonna ask you earlier on the XDA Chromecast forum if you were AsphyxNYC on the PlexPass forums, but I got busy around the house and never got around to it. Good to see a name on here that I recognize from XDA and I know that when I read a post of yours that it's gonna be very accurate and informative! XDA needs a few more like you on there!
LOL and Thanks...Yes I'm the same Schlub from XDA! LOL
There are a ton of smart folks over at XDA (and here as well) I just happen to work in Broadcasting on the engineering side so the CCast and Plex stuff is right up my alley which is why I have been active on both sites regarding the CCast.
ChromeCast doesn't support 5.0ghz
https://support.google.com/chromecast/answer/3046409?hl=en
Chromecast Specs:
- Output: HDMI, CEC (Consumer Electronics Control) compatible
- Max. Output Video Resolution: 1080p
- Dimensions: 72(L) x 35(W) x 12(H) mm
- Weight: 34g
- Wireless Standards: 802.11b/g/n Wi-Fi (802.11n 2.4GHz only)
- Wireless Security: WEP, WPA/WPA2
- Power: USB (USB cable and power adapter included)
- Plugs into TV directly and powered from TVs USB port or wall outlet
This is exactly the issue that I'm experiencing myself. Videos play fine on my PC through the web client or my phone but are stuttering on the Chromecast. Thanks for the post, it's pretty much the same process I'm going through right now (finding out what the issue is, is it the Chromecast, network, server, media file, etc.).
You mention to check your logs and to look for a speed entry. Where are these logs stored? I've checked the upstart logs (/var/log/upstart) as well as the plex logs (/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Logs/) and grep'd for speed but have had no results.
I've been having issues with the playback in plex/web and streaming to the CC. I've been over pretty much everything you mention but hadn't looked at the logs, so gave it a shot.
The transcoding is at 2.0 in speed, but then goes down to 0.0 a couple of times, then back up to 2.0 and so on. Any ideas as to why? Shouldn't my i7 be able to handle a single stream that's being transcoded?
(If this is the wrong place to ask, please direct me towards the right forum!)
You mention to check your logs and to look for a speed entry. Where are these logs stored? I've checked the upstart logs (/var/log/upstart) as well as the plex logs (/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Logs/) and grep'd for speed but have had no results.
The plex logs as you mention in the latter. Make sure you have debug logging turned on. It's found under the General settings, but you have to be showing the Advanced Settings. 'Plex Media Server debug logging' is the precise setting you are looking for. Restart Plex and try again.
The transcoding is at 2.0 in speed, but then goes down to 0.0 a couple of times, then back up to 2.0 and so on. Any ideas as to why? Shouldn't my i7 be able to handle a single stream that's being transcoded?
Ya...I would think any i7 would be able to handle a single transcoding session. Try again and see what your CPU and memory usage is while that is going on. The fact that it dips to 0 is concerning and may or may not indicate a buffering problem. If the transcoding is happening twice as fast as playback, you would think that a couple of dips down wouldn't cause stuttering playback since the transcoder is getting ahead of the playback. But one thing I do know is that the transcoder doesn't just keep going waaaay ahead of playback. You can see in the log '[Transcoder] Throttle - Going into sloth mode.' which means the transcoder pauses and waits for the playback to catch up some.
One suggestion for an edit:
Are you a PlexPass member?If not, you can stop here. Chromecast support is only available for PlexPass members at this time. You have to use the Plex for PlexPass version of the Android and iOS apps which require you to sign in with your PlexPass account. The paid app does not constitute you as a PlexPass member. [Please do not ask when it will be released to the general public, the Plex team never gives release dates.]
Can probably be removed.
If they are not a PlexPass member they can't see this post.
Ya...I would think any i7 would be able to handle a single transcoding session. Try again and see what your CPU and memory usage is while that is going on. The fact that it dips to 0 is concerning and may or may not indicate a buffering problem. If the transcoding is happening twice as fast as playback, you would think that a couple of dips down wouldn't cause stuttering playback since the transcoder is getting ahead of the playback. But one thing I do know is that the transcoder doesn't just keep going waaaay ahead of playback. You can see in the log '[Transcoder] Throttle - Going into sloth mode.' which means the transcoder pauses and waits for the playback to catch up some.
Well my cpu falls down to about 2-5% when this happens and I have plenty of free ram. Looked at the log, but nowhere does it say anything about throttle or sloth mode. Here's a copy of some of the log if it helps.
Jan 27, 2014 21:57:11:862 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=446308 [::ffff:127.0.0.1:55159] (3 live) Jan 27, 2014 21:57:11:862 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:11:862 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:11:862 [6240] DEBUG - * speed => 2.4 Jan 27, 2014 21:57:11:862 [6240] DEBUG - * remaining => 446308 Jan 27, 2014 21:57:11:866 [6240] DEBUG - HLS segment range: 160 - 169 average bitrate: 4.51 Mbps Jan 27, 2014 21:57:11:866 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 169. Jan 27, 2014 21:57:11:866 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:11:866 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=446308: 2200 Jan 27, 2014 21:57:11:866 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=446308, 0 bytes in 4025ms Jan 27, 2014 21:57:13:863 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453827 [::ffff:127.0.0.1:55166] (3 live) Jan 27, 2014 21:57:13:863 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:13:863 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:13:863 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:13:864 [8048] DEBUG - * remaining => 453827 Jan 27, 2014 21:57:13:866 [8048] DEBUG - HLS segment range: 160 - 169 average bitrate: 4.51 Mbps Jan 27, 2014 21:57:13:866 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 169. Jan 27, 2014 21:57:13:866 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:13:866 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453827: 2200 Jan 27, 2014 21:57:13:866 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453827, 0 bytes in 4009ms Jan 27, 2014 21:57:14:874 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55172] (3 live) Jan 27, 2014 21:57:14:874 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:14:874 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:14:874 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:14:874 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:14:876 [6240] DEBUG - HLS segment range: 160 - 169 average bitrate: 4.51 Mbps Jan 27, 2014 21:57:14:876 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 169. Jan 27, 2014 21:57:14:877 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:14:877 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:14:877 [8572] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3011ms Jan 27, 2014 21:57:17:875 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=-1 [::ffff:127.0.0.1:55176] (3 live) Jan 27, 2014 21:57:17:875 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:17:875 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:17:875 [8048] DEBUG - * speed => 2.4 Jan 27, 2014 21:57:17:875 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:17:879 [8048] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:17:879 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:17:879 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:17:880 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:17:880 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.4&remaining=-1: 2200 Jan 27, 2014 21:57:19:878 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55182] (3 live) Jan 27, 2014 21:57:19:878 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:19:878 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:19:878 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:19:878 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:19:881 [6240] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:19:881 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:19:881 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:19:881 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:19:881 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3994ms Jan 27, 2014 21:57:21:879 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55188] (3 live) Jan 27, 2014 21:57:21:879 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:21:879 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:21:879 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:21:879 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:21:882 [8048] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:21:882 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:21:882 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:21:882 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:21:882 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:23:880 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55191] (3 live) Jan 27, 2014 21:57:23:880 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:23:880 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:23:880 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:23:880 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:23:883 [6240] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:23:883 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:23:883 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:23:883 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:23:883 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:25:881 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55199] (3 live) Jan 27, 2014 21:57:25:881 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:25:881 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:25:881 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:25:881 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:25:884 [8048] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:25:884 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:25:884 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:25:884 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:25:884 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3994ms Jan 27, 2014 21:57:27:882 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55208] (3 live) Jan 27, 2014 21:57:27:882 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:27:882 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:27:882 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:27:883 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:27:885 [6240] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:27:885 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:27:885 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:27:885 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:27:885 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:28:883 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55212] (3 live) Jan 27, 2014 21:57:28:883 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:28:883 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:28:883 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:28:883 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:28:885 [8048] DEBUG - HLS segment range: 160 - 170 average bitrate: 4.57 Mbps Jan 27, 2014 21:57:28:886 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 170. Jan 27, 2014 21:57:28:886 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:28:886 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:28:886 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3011ms Jan 27, 2014 21:57:31:883 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1 [::ffff:127.0.0.1:55227] (3 live) Jan 27, 2014 21:57:31:883 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:31:883 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:31:883 [6240] DEBUG - * speed => 2.5 Jan 27, 2014 21:57:31:883 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:31:887 [6240] DEBUG - HLS segment range: 160 - 171 average bitrate: 4.65 Mbps Jan 27, 2014 21:57:31:887 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 171. Jan 27, 2014 21:57:31:887 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:31:887 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1: 2200 Jan 27, 2014 21:57:31:887 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:33:885 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453324 [::ffff:127.0.0.1:55232] (3 live) Jan 27, 2014 21:57:33:885 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:33:885 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:33:885 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:33:885 [8048] DEBUG - * remaining => 453324 Jan 27, 2014 21:57:33:888 [8048] DEBUG - HLS segment range: 160 - 171 average bitrate: 4.65 Mbps Jan 27, 2014 21:57:33:888 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 171. Jan 27, 2014 21:57:33:888 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:33:888 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453324: 2200 Jan 27, 2014 21:57:33:888 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453324, 0 bytes in 3994ms Jan 27, 2014 21:57:35:886 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55239] (3 live) Jan 27, 2014 21:57:35:886 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:35:886 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:35:886 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:35:886 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:35:889 [6240] DEBUG - HLS segment range: 160 - 171 average bitrate: 4.65 Mbps Jan 27, 2014 21:57:35:889 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 171. Jan 27, 2014 21:57:35:889 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:35:889 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:35:889 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 4009ms Jan 27, 2014 21:57:36:887 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55256] (3 live) Jan 27, 2014 21:57:36:887 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:36:887 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:36:887 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:36:887 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:36:890 [8048] DEBUG - HLS segment range: 160 - 171 average bitrate: 4.65 Mbps Jan 27, 2014 21:57:36:890 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 171. Jan 27, 2014 21:57:36:890 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:36:890 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:36:890 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3011ms Jan 27, 2014 21:57:39:891 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.3&remaining=446389 [::ffff:127.0.0.1:55278] (3 live) Jan 27, 2014 21:57:39:891 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:39:891 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:39:891 [6240] DEBUG - * speed => 2.3 Jan 27, 2014 21:57:39:892 [6240] DEBUG - * remaining => 446389 Jan 27, 2014 21:57:39:895 [6240] DEBUG - HLS segment range: 160 - 172 average bitrate: 4.71 Mbps Jan 27, 2014 21:57:39:895 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 172. Jan 27, 2014 21:57:39:895 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:39:895 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.3&remaining=446389: 2200 Jan 27, 2014 21:57:39:896 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.3&remaining=446389, 0 bytes in 4009ms Jan 27, 2014 21:57:41:892 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453435 [::ffff:127.0.0.1:55282] (3 live) Jan 27, 2014 21:57:41:892 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:41:892 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:41:892 [8048] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:41:892 [8048] DEBUG - * remaining => 453435 Jan 27, 2014 21:57:41:895 [8048] DEBUG - HLS segment range: 160 - 172 average bitrate: 4.71 Mbps Jan 27, 2014 21:57:41:895 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 172. Jan 27, 2014 21:57:41:895 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:41:895 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453435: 2200 Jan 27, 2014 21:57:41:895 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453435, 0 bytes in 4009ms Jan 27, 2014 21:57:42:892 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1 [::ffff:127.0.0.1:55288] (3 live) Jan 27, 2014 21:57:42:892 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:42:892 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:42:892 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:42:892 [6240] DEBUG - * remaining => -1 Jan 27, 2014 21:57:42:895 [6240] DEBUG - HLS segment range: 160 - 172 average bitrate: 4.71 Mbps Jan 27, 2014 21:57:42:895 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 172. Jan 27, 2014 21:57:42:895 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:42:895 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1: 2200 Jan 27, 2014 21:57:42:895 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=-1, 0 bytes in 3011ms Jan 27, 2014 21:57:44:904 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1 [::ffff:127.0.0.1:55299] (3 live) Jan 27, 2014 21:57:44:904 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:44:904 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:44:904 [8048] DEBUG - * speed => 2.5 Jan 27, 2014 21:57:44:905 [8048] DEBUG - * remaining => -1 Jan 27, 2014 21:57:44:908 [8048] DEBUG - HLS segment range: 160 - 173 average bitrate: 4.75 Mbps Jan 27, 2014 21:57:44:908 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 173. Jan 27, 2014 21:57:44:908 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:44:908 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1: 2200 Jan 27, 2014 21:57:44:909 [8572] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.5&remaining=-1, 0 bytes in 3026ms Jan 27, 2014 21:57:46:901 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.2&remaining=4051 [::ffff:127.0.0.1:55311] (4 live) Jan 27, 2014 21:57:46:901 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:46:901 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:46:901 [6240] DEBUG - * speed => 2.2 Jan 27, 2014 21:57:46:901 [6240] DEBUG - * remaining => 4051 Jan 27, 2014 21:57:46:905 [6240] DEBUG - HLS segment range: 160 - 174 average bitrate: 4.76 Mbps Jan 27, 2014 21:57:46:906 [6240] DEBUG - We want 240 segments ahead, last returned was 164 and max is 174. Jan 27, 2014 21:57:46:906 [6240] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:46:906 [6240] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.2&remaining=4051: 2200 Jan 27, 2014 21:57:46:906 [8572] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.2&remaining=4051, 0 bytes in 3011ms Jan 27, 2014 21:57:49:906 [8048] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.1&remaining=4412 [::ffff:127.0.0.1:55321] (4 live) Jan 27, 2014 21:57:49:906 [8048] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:49:906 [8048] DEBUG - * size => -22 Jan 27, 2014 21:57:49:906 [8048] DEBUG - * speed => 2.1 Jan 27, 2014 21:57:49:906 [8048] DEBUG - * remaining => 4412 Jan 27, 2014 21:57:49:910 [8048] DEBUG - HLS segment range: 160 - 175 average bitrate: 4.83 Mbps Jan 27, 2014 21:57:49:910 [8048] DEBUG - We want 240 segments ahead, last returned was 164 and max is 175. Jan 27, 2014 21:57:49:910 [8048] DEBUG - It took 0.000000 sec to serialize a list with 0 elements. Jan 27, 2014 21:57:49:911 [8048] VERBOSE - Completed request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.1&remaining=4412: 2200 Jan 27, 2014 21:57:49:911 [9168] VERBOSE - Finished writing response for PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=2.1&remaining=4412, 0 bytes in 4009ms Jan 27, 2014 21:57:51:908 [6240] DEBUG - Request: PUT /video/:/transcode/session/51ua4top6jqq6w29/progress?progress=0.0&size=-22&speed=0.0&remaining=453681 [::ffff:127.0.0.1:55330] (3 live) Jan 27, 2014 21:57:51:908 [6240] DEBUG - * progress => 0.0 Jan 27, 2014 21:57:51:908 [6240] DEBUG - * size => -22 Jan 27, 2014 21:57:51:908 [6240] DEBUG - * speed => 0.0 Jan 27, 2014 21:57:51:908 [6240] DEBUG - * remaining => 453681
Out of nowhere yesterday and today I started having stuttering issues on some videos and I am not sure why. I haven't changed anything. The videos seem to both be MKV files. They play fine on my computer, Plex web, and Android phone/tablet. I doubt it's my server seeing as my computer is sitting at single digit CPU while streaming and with under 40% memory utilization. I factory reset my Chromecast too. I would test on another Chromecast but my wife is sleeping now :P
Edit: So I tested on another Chromecast today, same thing. Stuttering on videos that previously didn't stutter.
Any thoughts? My log file says my speed is either 6, 8, or 11.
I just fixed some issues i was having with streaming. I was trying to playback some mkv/h.264@720p/ac3 files the cpu in my NAS could not keep up as it was trying to transcode the video rather than just the audio. Checking the logs showed an exceeded bandwidth limitation as the reason for the transcode and indicated the limit was 4mbps (my video was ~4.4). I checked my player settings and had no such limitation. However it looks like the Chromecast.xml profile has bandwidth limits for transcoded video set to 4000 i bumped this up to 8000 and it streams fine now. I couldn't find any documentation to specify what the actual device limit is.
I did also notice that the VideoCodec limitations indicate 1080p but the VideoTranscodeTarget limits are only 720p. I think this may cause unnecessary transcoding of 1080p video tracks if the transcoder is invoked for the audio track?
I did also notice that the VideoCodec limitations indicate 1080p but the VideoTranscodeTarget limits are only 720p. I think this may cause unnecessary transcoding of 1080p video tracks if the transcoder is invoked for the audio track?
Plex has introduced a forced downward transcode from 1080p to 720p based on their testing of Chromecast's lack of ability to handle the 1080p stream from Plex. I think they are working on efficiencies to try and remove this limitation.
The limitations in the XML profile are there for a reason based on extensive testing. Folks can, of course, always edit theirs, but we *do not recommend* doing so.
There's definitely a lot of work being done for Chromecast stuff right now. Recent Plex Pass preview release PMS builds have included improvements. You can expect more improvements to come in the future.
Yeah i've since had a few issues with others files at much higher bitrates. It looks like the file i originally had an issue with is ok as it's only just above 4mbps but when i tried on something more like a 7mbps file the chromecast chokes every few minutes, I only set it to 8 as that was the bitrate recommended in the first post. Looks like my shiny new chromecast is going to sit in a draw with all my other redundant gadgets at least for a while and i'll have to go back to LG medialink for now.
Please try out the latest version of Plex Media Server (0.9.9.5). Quality and reliability on Chromecast should be significantly improved.
Please try out the latest version of Plex Media Server (0.9.9.5). Quality and reliability on Chromecast should be significantly improved.
No improvement here. Video is stuttering to the point where even my kids didn't want to watch their movie. MKV. Bitrate: 5150kpbs. h264 video codec. DCA audio codec. Edit: here's a pastebin of the log when it was skipping. http://pastebin.com/S5EdFwxE
No improvement here. Video is stuttering to the point where even my kids didn't want to watch their movie. MKV. Bitrate: 5150kpbs. h264 video codec. DCA audio codec. Edit: here's a pastebin of the log when it was skipping. http://pastebin.com/S5EdFwxE
Add me to the list that 0.9.9.5 did not improve/fix the problem.
Here are my details:
I am running the latest version of Plex Media Server for the Mac (Version 0.9.9.5.411-da1d892) on a Macbook Pro running the latest version of OSX (10.9.1) with 4gb of RAM and having the same issue with Chromecast. My router is < 1m from the Chromecast and not on a clobbered channel. I am running 720p mkv files that work fine when I run them on my iPad or iPhone and then send them to my AppleTV using Airplay. Why would it be able to transcode just fine for the Apple and not for Google Chromecast if it is transcoding them both into mp4? Not sure the general statement in the original post pertains. Apple is pretty notorious for only accepting mp4 --- which is what led me to Plex in the first place.
This seems to be an issue with Chromecast or the Plex to Chromecast interface. Any tekkies out there know enough about Chromecast Plex app's internal workings to speculate?
I figured I'd save some cash by not buying another AppleTv but rather a Chromecast for my other tv. Looks like a bad investment as of 03 March 2014.
Add me to the list that 0.9.9.5 did not improve/fix the problem.
Here are my details:
I am running the latest version of Plex Media Server for the Mac (Version 0.9.9.5.411-da1d892) on a Macbook Pro running the latest version of OSX (10.9.1) with 4gb of RAM and having the same issue with Chromecast. My router is < 1m from the Chromecast and not on a clobbered channel. I am running 720p mkv files that work fine when I run them on my iPad or iPhone and then send them to my AppleTV using Airplay. Why would it be able to transcode just fine for the Apple and not for Google Chromecast if it is transcoding them both into mp4? Not sure the general statement in the original post pertains. Apple is pretty notorious for only accepting mp4 --- which is what led me to Plex in the first place.
This seems to be an issue with Chromecast or the Plex to Chromecast interface. Any tekkies out there know enough about Chromecast Plex app's internal workings to speculate?
I figured I'd save some cash by not buying another AppleTv but rather a Chromecast for my other tv. Looks like a bad investment as of 03 March 2014.
We need logs in order to help you. Also, the container and encoding details of the files you are trying to play are required too.