Unable to cast. This media is currently unavailable.

chromecast

#1

Whenever I try to stream to Chromecast on my tv using the Plex web player, this appears on my screen. "Unable to cast. This media is currently unavailable."

 

Streaming works from my iPhone, just not my Macbook. Any suggestions?


#2

Are casting a channel or local media? Can you restart your media server, attempt to cast from the web app so it displays the error, and share your Plex Media Server log?


#3

I am having the same issue, went on vacation for the weekend and now it's no longer playing my media giving me the same error. already restarted computer, router, and chromecast. Which log files are you looking for?


#4

I'm getting the same error message, if i go to http://127.0.0.1:32400/web/ and play then it works and i can cast the tab but if i go to http://plex.tv/web/app and try to play it then i get media is currently unavailable.


#5

Having the same problem here, Chrome casting works fine but as soon as I try to cast in plex ´my tv/chromecast says unable to cast and the plex web app says ...media is currently unavailable....

First time using plex and chromecast, got it today. But I'm sure I have done everything right, followed this guide: http://allaboutchromecast.com/how-to-use-plex-media-server-to-stream-local-media-to-chromecast-from-your-pc/

Really annoying problem :/


#6

Are you casting local media? We can't really help unless you follow the above instructions to provide us a Plex Media Server log.

https://support.plex.tv/hc/en-us/articles/200250417-Plex-Media-Server-Log-Files


#7

Having the same problem here, Chrome casting works fine but as soon as I try to cast in plex ´my tv/chromecast says unable to cast and the plex web app says ...media is currently unavailable....

First time using plex and chromecast, got it today. But I'm sure I have done everything right, followed this guide: http://allaboutchromecast.com/how-to-use-plex-media-server-to-stream-local-media-to-chromecast-from-your-pc/

Really annoying problem :/

Looking at the tutorial it doesn't mention installing the "google cast" extension on your chrome browser.

https://support.plex.tv/hc/en-us/articles/201206866-Cast-from-Browser-or-Desktop

That is required for you to be ale to cast from the desktop browser


#8

Are you casting local media? We can't really help unless you follow the above instructions to provide us a Plex Media Server log.

https://support.plex.tv/hc/en-us/articles/200250417-Plex-Media-Server-Log-Files

So how are suppose to submit our logs? just post it here on the forums? File is too big to attach to the forums 


#9

So how are suppose to submit our logs? just post it here on the forums? File is too big to attach to the forums 

Close/shutdown PMS, then start it back up.

Play something that gives you the error in question

After that get the log file.

Shutting down the PMS will clear the log out so only the media you just played with be there.

And yes paste the file into your post


#10

I am having the same issue,  running local server 9.9.9 and also connecting to a remote server.  Most of the time the video starts and freezes after a second, then chromecast reboots,  I also have gotten the unable to cast screen.  I have rebooted the server, reset chromecast to factory and still have the issue,  I rebooted the router this morning but have not tested it out yet.  The rest of my apps, pandora, youtube work just fine.  The Plex app on the ipad thinks the video is still playing but the timeline does not move, sometimes the pause or stop buttons will work, sometimes not.  I can put up my log file later.


#11

Here it is, plex see's it on web app but streaming doesn't work anymore. Not sure what changed but maybe someone can make sense of what happened.

May 07, 2014 13:05:42:020 [6564] DEBUG - Starting Plex DLNA Server 0.9.9.7.429-f80a8d6...
May 07, 2014 13:05:42:020 [6564] DEBUG - Unique device name = 75ff3d14-f3e2-598f-f4f9-78981dac0a60
May 07, 2014 13:05:42:020 [6564] DEBUG - DLNA server port: 32469
May 07, 2014 13:05:42:020 [6564] DEBUG - PMS: http://127.0.0.1:32400/
May 07, 2014 13:05:42:020 [6564] DEBUG - MyPlex: https://plex.tv/
May 07, 2014 13:05:42:122 [6564] DEBUG - Reading system DLNA client profiles
May 07, 2014 13:05:42:150 [6564] DEBUG - Read 16 DLNA client profiles
May 07, 2014 13:05:42:157 [6564] DEBUG - DLNA device discovery enabled every 60 seconds
May 07, 2014 13:05:42:160 [6564] DEBUG - Initialization complete
May 07, 2014 13:09:50:519 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/027d672c6a70ab72aa7c/260x260.png
May 07, 2014 13:09:50:519 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:525 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260: HTTP/1.1 200
May 07, 2014 13:09:50:525 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:699 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/74b2fce849107951c424/120x120.png
May 07, 2014 13:09:50:699 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:705 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120: HTTP/1.1 200
May 07, 2014 13:09:50:705 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:730 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/23b1739a6c33d02bf0ba/48x48.png
May 07, 2014 13:09:50:731 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:736 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48: HTTP/1.1 200
May 07, 2014 13:09:50:736 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:751 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/e2ba69ed701bbef38438/260x260.jpg
May 07, 2014 13:09:50:751 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:757 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260: HTTP/1.1 200
May 07, 2014 13:09:50:757 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:772 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/ae306aa36533cd3e14b4/120x120.jpg
May 07, 2014 13:09:50:773 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:778 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120: HTTP/1.1 200
May 07, 2014 13:09:50:778 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:816 [3552] DEBUG - GET for http://192.168.1.103:32469/proxy/f5095c764513b3c19c6b/48x48.jpg
May 07, 2014 13:09:50:816 [3552] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:822 [3552] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48: HTTP/1.1 200
May 07, 2014 13:09:50:822 [3552] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:50:972 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/027d672c6a70ab72aa7c/260x260.png
May 07, 2014 13:09:50:973 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:50:978 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260: HTTP/1.1 200
May 07, 2014 13:09:50:978 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:51:043 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/74b2fce849107951c424/120x120.png
May 07, 2014 13:09:51:043 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:51:049 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120: HTTP/1.1 200
May 07, 2014 13:09:51:049 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:51:069 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/23b1739a6c33d02bf0ba/48x48.png
May 07, 2014 13:09:51:070 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:51:075 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48: HTTP/1.1 200
May 07, 2014 13:09:51:075 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:51:098 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/e2ba69ed701bbef38438/260x260.jpg
May 07, 2014 13:09:51:098 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:51:104 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260: HTTP/1.1 200
May 07, 2014 13:09:51:104 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:51:127 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/ae306aa36533cd3e14b4/120x120.jpg
May 07, 2014 13:09:51:127 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:51:133 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120: HTTP/1.1 200
May 07, 2014 13:09:51:133 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:09:51:144 [7456] DEBUG - GET for http://192.168.1.103:32469/proxy/f5095c764513b3c19c6b/48x48.jpg
May 07, 2014 13:09:51:144 [7456] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: User-Agent: Microsoft-DLNA DLNADOC/1.50; Host: 192.168.1.103:32469
May 07, 2014 13:09:51:150 [7456] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48: HTTP/1.1 200
May 07, 2014 13:09:51:150 [7456] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:21:28:101 [7868] DEBUG - GET for http://192.168.1.103:32469/proxy/23b1739a6c33d02bf0ba/48x48.png
May 07, 2014 13:21:28:101 [7868] DEBUG - Mapped client to generic profile: Connection: Keep-Alive; User-Agent: Windows-Media-Player-DMS/12.0.7601.17514; Host: 192.168.1.103:32469
May 07, 2014 13:21:28:103 [7868] DEBUG - Proxied GET to http://127.0.0.1:32400/photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48: HTTP/1.1 200
May 07, 2014 13:21:28:103 [7868] DEBUG - Responding HTTP/1.1 200
May 07, 2014 13:24:07:706 [6564] DEBUG - Stopping UPNP server
May 07, 2014 13:24:08:013 [6564] DEBUG - Stopped UPNP server

#12

I have also began encountering the same issue today. I also do not get the media poster/previews where I used to after selecting a film.

Update: Oddly enough, after factory resetting the Chromecast twice it has begun working.. Not sure if there a problem remotely and coincidentally it got fixed during my second factory reset, but all is well on my end for now.


#13

2nd factory reset on Chromecast - problem still exists. 


#14

How to I get my Media Server log?


#15

Are casting a channel or local media? Can you restart your media server, attempt to cast from the web app so it displays the error, and share your Plex Media Server log?

How do I get my media server log?


#16

Here it is, plex see's it on web app but streaming doesn't work anymore. Not sure what changed but maybe someone can make sense of what happened.

May 07, 2014 13:05:42:020 [6564] DEBUG - Starting Plex DLNA Server 0.9.9.7.429-f80a8d6...

That looks like DLNA log, not the Plex Media Server log. The Chromecast does not use DLNA, so those logs don't tell us anything about the problem.

How do I get my media server log?

The support link I posted has details on where the log is: https://support.plex.tv/hc/en-us/articles/200250417-Plex-Media-Server-Log-Files

You'll want to restart your media server to clear out the existing logs. Then connect to the Chromecast and either navigate to the details for an item to trigger content mirroring or attempt to play an item. Wait for the error message, and zip up or paste to a text file and share the log with me.


#17

That looks like DLNA log, not the Plex Media Server log. The Chromecast does not use DLNA, so those logs don't tell us anything about the problem.

The support link I posted has details on where the log is: https://support.plex.tv/hc/en-us/articles/200250417-Plex-Media-Server-Log-Files

You'll want to restart your media server to clear out the existing logs. Then connect to the Chromecast and either navigate to the details for an item to trigger content mirroring or attempt to play an item. Wait for the error message, and zip up or paste to a text file and share the log with me.

Is this it? see attachment. 

 

#18

Ok, after some testing I am very sure it is not a Plex issue, all of my apps from the Ipad have the same result,  video or music starts for a second or two and stops.  I have tried this on two different wireless networks and 3 different tv's and in every case I get the same result with and without the power supply.  I have removed and added the app back with no luck.

Streaming from a pc to chromecast (tab casting) works fine, plex works as well.  So the issue lies between the chromecast and the handoff from the Ipad.  If I find anything else out I will post it, I am hoping that there is a chromecast update on its way to fix the issue.


#19

im having the same issue!


#20
May 10, 2014 02:01:23 [0x1076f4000] DEBUG - HTTP requesting to: https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG - Setting AppCast URL to https://www.plexapp.com/appcast/mac/pms.xml.
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG - Network interfaces:
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG -  * 1 lo0 (127.0.0.1) (loopback: 1)
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG -  * 5 en1 (192.168.0.101) (loopback: 0)
May 10, 2014 02:01:24 [0x10787a000] INFO - Plex Media Server v0.9.9.7.429-f80a8d6 - Apple Mac 
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Opening 20 database sessions to library, SQLite 3.8.0.2, threadsafe=1
May 10, 2014 02:01:24 [0x10787a000] INFO - SQLITE3:10, 283, recovered 34 frames from WAL file /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-in Support/Databases/com.plexapp.plugins.library.db-wal
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Running migrations.
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Listening on port 32400 with queue of 128 connections.
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Listening on port 32443 with queue of 128 connections.
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Adding directory for site configurations: /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources
May 10, 2014 02:01:24 [0x10787a000] DEBUG - The path changed: /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources.
May 10, 2014 02:01:24 [0x10787a000] DEBUG - This corresponds to site configuration map: /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources (directory: 1)
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Adding directory for site configurations: /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations
May 10, 2014 02:01:24 [0x10787a000] DEBUG - The path changed: /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations.
May 10, 2014 02:01:24 [0x10787a000] DEBUG - This corresponds to site configuration map: /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations (directory: 1)
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - File /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources changed: -1 => 1394678721.
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - File /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations changed: -1 => 1399671367.
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - The path changed: /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources.
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - This corresponds to site configuration map: /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle/Contents/Resources (directory: 1)
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - The path changed: /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations.
May 10, 2014 02:01:24 [0x109f1e000] DEBUG - This corresponds to site configuration map: /Users/lukaskruger/Library/Application Support/Plex Media Server/Site Configurations (directory: 1)
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Setting up scheduled updates
May 10, 2014 02:01:24 [0x10787a000] INFO - LibraryUpdateManager path watching is disabled
May 10, 2014 02:01:24 [0x109fa1000] DEBUG - Starting scheduled updates, every 3600 seconds
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Checking for blacklisted version for Framework.bundle (version 279a6af)
May 10, 2014 02:01:24 [0x10787a000] DEBUG - Checking for blacklisted version for System.bundle (version c259f60)
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - File /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins changed: -1 => 1399672075.
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - Scanning for plug-ins in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/System.bundle.
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - Starting file watcher for com.plexapp.system
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - Spawned plug-in com.plexapp.system with PID 1898
May 10, 2014 02:01:24 [0x10a2f2000] DEBUG - [com.plexapp.system] Sent command: GET /:/prefixes
May 10, 2014 02:01:24 [0x7fff72138310] DEBUG - WebKit supports Flash content
May 10, 2014 02:01:24 [0x7fff72138310] WARN - WebKit does not support Silverlight, you may need to install Silverlight for certain channels to work
May 10, 2014 02:01:24 [0x1076f4000] DEBUG - MyPlex: Updating device connections.
May 10, 2014 02:01:24 [0x10a3f8000] DEBUG - Sync: myPlexSignIn
May 10, 2014 02:01:24 [0x1076f4000] DEBUG - HTTP requesting to: https://plex.tv/devices/55cf7002929d6e3a7946084bfbe50520d5d0cc3f?Connection[][uri]=http://192.168.0.101:32400&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - Reading 486 bytes in the body, code is 200
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - [com.plexapp.system] Plug-in running on port 57004.
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG -  * Plug-in handles prefix: /system
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG -  * Plug-in handles prefix: /player
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - Updating the list of agents known by the system.
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
May 10, 2014 02:01:27 [0x10a2f2000] DEBUG - HTTP requesting to: http://127.0.0.1:57004/system/agents
May 10, 2014 02:01:27 [0x10787a000] DEBUG - Found 1 library files
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Found 103 genre icons
May 10, 2014 02:01:28 [0x10787a000] DEBUG - iTunes: There are 686 audio tracks and 3 video tracks.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - iPhoto: Found 1 library files
May 10, 2014 02:01:28 [0x10787a000] DEBUG - iPhoto: Refreshing iPhoto album tree.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - iPhoto: Done refreshing album tree
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Aperture: Found 0 library files
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Image transcode cache directory: /Users/lukaskruger/Library/Caches/PlexMediaServer/PhotoTranscoder
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NAT: Starting Mapping Thread.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NAT: Using previously obtained port of 20330.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NAT: Creating NAT puncher thread 0x104c3cab0
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Updating mapping in puncher thread 0x104c3cab0
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Creating NetworkServices singleton.
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Creating puncher.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NetworkServices: Initializing...
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Switching to NAT-PMP strategy.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a47400: Creating new Network Service and registering for notifications.
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Creating NATPmPPuncher.
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Initializing NAT-PMP, success=1
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Finding public address failed the first way, switching.
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Switching to UPnP strategy.
May 10, 2014 02:01:28 [0x10a687000] DEBUG - NAT: Creating NATUPnPPuncher.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a47400: NetworkService got notification of changed network (first change: 1)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NetworkService: Quick dispatch of network change.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a49600: Creating new Network Service and registering for notifications.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a49600: NetworkService got notification of changed network (first change: 1)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NetworkService: Quick dispatch of network change.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a4b800: Creating new Network Service and registering for notifications.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105a4b800: NetworkService got notification of changed network (first change: 1)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NetworkService: Quick dispatch of network change.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105307600: Creating new Network Service and registering for notifications.
May 10, 2014 02:01:28 [0x10787a000] DEBUG - 0x105307600: NetworkService got notification of changed network (first change: 1)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - NetworkService: Quick dispatch of network change.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - Network change for advertiser.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414 (outbound: 0)
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - Network change for advertiser.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410 (outbound: 0)
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - Network change for browser (polled=0), closing 0 browse sockets.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413 (outbound: 0)
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Browsing on interface 192.168.0.101 on broadcast address 192.168.0.255 (index: 1)
May 10, 2014 02:01:28 [0x10a78d000] DEBUG - DLNA server starting.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - Network change for browser (polled=1), closing 0 browse sockets.
May 10, 2014 02:01:28 [0x10a78d000] DEBUG - Job running: /Applications/Plex Media Server.app/Contents/MacOS/Plex DLNA Server 
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Starting HTTP server.
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Running server...
May 10, 2014 02:01:28 [0x10a70a000] DEBUG - NetworkService: Browsing on interface 192.168.0.101 on broadcast address 192.168.0.255 (index: 1)
May 10, 2014 02:01:28 [0x10787a000] DEBUG - Waiting for server condition to be signaled.
May 10, 2014 02:01:28 [0x10a810000] DEBUG - Set up a thread pool for HTTP server with 2 threads.
May 10, 2014 02:01:28 [0x10a810000] DEBUG - Running database fix-ups.
May 10, 2014 02:01:28 [0x10a893000] DEBUG - Request: [127.0.0.1:57000] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (5 live)
May 10, 2014 02:01:28 [0x10a916000] DEBUG - Request: [127.0.0.1:57001] GET / (5 live)
May 10, 2014 02:01:28 [0x10a893000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
May 10, 2014 02:01:28 [0x10a999000] DEBUG - Request: [127.0.0.1:57002] GET / (5 live)
May 10, 2014 02:01:28 [0x10a893000] DEBUG - HTTP requesting to: http://127.0.0.1:57004/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - Request: [127.0.0.1:57003] GET /servers (5 live)
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - It took 0.000071 sec to serialize a list with 1 elements.
May 10, 2014 02:01:28 [0x10a916000] DEBUG - It took 0.000125 sec to serialize a list with 14 elements.
May 10, 2014 02:01:28 [0x10a999000] DEBUG - It took 0.000172 sec to serialize a list with 14 elements.
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - Request: [127.0.0.1:57007] GET / (5 live)
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - It took 0.000088 sec to serialize a list with 14 elements.
May 10, 2014 02:01:28 [0x10a916000] DEBUG - Request: [127.0.0.1:57008] GET / (5 live)
May 10, 2014 02:01:28 [0x10a916000] DEBUG - It took 0.000085 sec to serialize a list with 14 elements.
May 10, 2014 02:01:28 [0x10a999000] DEBUG - Request: [192.168.0.101:57009] GET /library/sections (5 live)
May 10, 2014 02:01:28 [0x10a999000] DEBUG - It took 0.000330 sec to serialize a list with 1 elements.
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - Request: [192.168.0.101:57011] GET /channels/all (5 live)
May 10, 2014 02:01:28 [0x10aa1c000] DEBUG - It took 0.000068 sec to serialize a list with 3 elements.
May 10, 2014 02:01:29 [0x1077f7000] DEBUG - Crash Reporter: Starting up.
May 10, 2014 02:01:31 [0x1077f7000] DEBUG - Device: Apple Mac 
May 10, 2014 02:01:31 [0x1077f7000] DEBUG - HTTP requesting to: http://www.google-analytics.com/collect
May 10, 2014 02:01:31 [0x1077f7000] DEBUG - Sent analytics request: 200
May 10, 2014 02:01:38 [0x10a2f2000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 4972 bytes of content.
May 10, 2014 02:01:38 [0x10a893000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 85626 bytes of content.
May 10, 2014 02:01:38 [0x10a2f2000] DEBUG - The system knows about 11 agents.
May 10, 2014 02:01:38 [0x10a2f2000] DEBUG - Waiting for all 18 plug-ins to finish starting.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/Framework.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/HTbackdrops.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/IMDB.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/LastFM.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/LocalMedia.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/Media-Flags.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/MoviePosterDB.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/OpenSubtitles.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.opensubtitles] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/PersonalMedia.bundle.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/PlexThemeMusic.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/Scanners.bundle.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
May 10, 2014 02:01:38 [0x10a999000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/Services.bundle.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/SiteConfigurations.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/The-Movie-Database.bundle.
May 10, 2014 02:01:38 [0x10a999000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/TheTVDB.bundle.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/WebClient.bundle.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
May 10, 2014 02:01:38 [0x10a3f8000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/WebManager.bundle.
May 10, 2014 02:01:38 [0x10a999000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Starting plug-in /Users/lukaskruger/Library/Application Support/Plex Media Server/Plug-ins/Wikipedia.bundle.
May 10, 2014 02:01:38 [0x10a916000] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.wikipedia] yet.
May 10, 2014 02:01:38 [0x10a2f2000] DEBUG - Done waiting for all plug-ins to start.
May 10, 2014 02:01:38 [0x10aa1c000] DEBUG - HTTP requesting to: https://plex.tv/servers/55cf7002929d6e3a7946084bfbe50520d5d0cc3f/sync_lists?auth_token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:39 [0x10aa1c000] DEBUG - Sync: downloaded 0 sync lists, analyzing now...
May 10, 2014 02:01:39 [0x10aa1c000] INFO - Sync: analyzed 0 sync list(s) with 0 sync items(s)
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Initialized UPnP, result: UPnP Discovery failed!
May 10, 2014 02:01:40 [0x10a687000] DEBUG - HTTP requesting to: http://plex.tv/pms/:/ip
May 10, 2014 02:01:40 [0x10a687000] DEBUG - MyPlex: Got public IP from http://plex.tv: 31.208.71.252
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Obtained public address of 31.208.71.252 (failed: 0 myPlex: 1).
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Checking for change in address: old was  and new is 31.208.71.252.
May 10, 2014 02:01:40 [0x10a687000] WARN - NAT: Not unmapping ports via UPnP, state=65537, controlURL=(null), serviceType=
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Unmapping ports failed the first way, switching.
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Switching to NAT-PMP strategy.
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Unmapping port via NAT-PMP
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Finished NAT-PMP request, result was: Not Supported by gateway
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Unmapped port via NAT-PMP (success=0).
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Mapping port via NAT-PMP
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Finished NAT-PMP request, result was: Not Supported by gateway
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Mapped ports (success=0) private: 0 public 0
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Mapping ports failed the first way, switching.
May 10, 2014 02:01:40 [0x10a687000] DEBUG - NAT: Switching to UPnP strategy.
May 10, 2014 02:01:40 [0x10a687000] WARN - NAT: Not mapping ports via UPnP, state=65537, controlURL=(null), serviceType=
May 10, 2014 02:01:40 [0x10a687000] ERROR - NAT: Mapping failed (UPnP Discovery failed!)
May 10, 2014 02:01:40 [0x10a687000] DEBUG - It took 0.000323 sec to serialize a list with 2 elements.
May 10, 2014 02:01:40 [0x10a687000] DEBUG - MyPlex: Sending Server Info to myPlex (user=lukaskruger, ip=, port=0)
May 10, 2014 02:01:40 [0x10a687000] DEBUG - HTTP requesting to: https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:41 [0x10a687000] DEBUG - MyPlex: Published Mapping State <--- 422
May 10, 2014 02:01:41 [0x10a687000] WARN - MyPlex: Invalid response when mapping state (code=422):
 
 
 
May 10, 2014 02:01:41 [0x10a687000] ERROR - Error parsing content.
May 10, 2014 02:01:41 [0x10a687000] ERROR - MyPlex: Error parsing XML:
 
May 10, 2014 02:01:41 [0x10a687000] DEBUG - MyPlex: Updating device connections.
May 10, 2014 02:01:41 [0x10a687000] DEBUG - HTTP requesting to: https://plex.tv/devices/55cf7002929d6e3a7946084bfbe50520d5d0cc3f?Connection[][uri]=http://192.168.0.101:32400&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:42 [0x10a687000] DEBUG - NAT: Updating mapping complete in thread 0x104c3cab0.
May 10, 2014 02:01:42 [0x10a687000] DEBUG - NAT: Deleting puncher.
May 10, 2014 02:01:42 [0x10a687000] DEBUG - NAT: Deleting NATUPnPPuncher.
May 10, 2014 02:01:42 [0x10a687000] DEBUG - NAT: Deleting NATPmPPuncher.
May 10, 2014 02:01:42 [0x10a687000] DEBUG - NAT: We're going to next poll in 16.4 hours.
May 10, 2014 02:01:43 [0x10a70a000] DEBUG - NetworkServiceBrowser: SERVER arrived: 192.168.0.101 (Lukas Krügers MacBook Pro)
May 10, 2014 02:01:43 [0x10a70a000] DEBUG - Notifying the system bundle an update to server /system/notify/serverUpdated?host=192.168.0.101
May 10, 2014 02:01:43 [0x10a70a000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/notify/serverUpdated?host=192.168.0.101
May 10, 2014 02:01:43 [0x10a70a000] DEBUG - HTTP requesting to: http://127.0.0.1:57004/system/notify/serverUpdated?host=192.168.0.101
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57035] GET /servers (10 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - It took 0.000027 sec to serialize a list with 1 elements.
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [192.168.0.101:57036] GET /library/sections (10 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - It took 0.000307 sec to serialize a list with 1 elements.
May 10, 2014 02:01:43 [0x10a893000] DEBUG - Request: [192.168.0.101:57037] GET /channels/all (10 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - It took 0.000055 sec to serialize a list with 3 elements.
May 10, 2014 02:01:43 [0x10a70a000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 0 bytes of content.
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57038] OPTIONS / (10 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - Request: [127.0.0.1:57040] GET / (10 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - It took 0.000085 sec to serialize a list with 14 elements.
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57041] OPTIONS /clients (10 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - Request: [127.0.0.1:57042] OPTIONS /status/sessions (10 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57043] OPTIONS /:/prefs (11 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - Request: [127.0.0.1:57046] OPTIONS /servers (11 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57047] OPTIONS /library/sections (11 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57048] OPTIONS /library/onDeck (11 live)
May 10, 2014 02:01:43 [0x10a893000] DEBUG - Request: [127.0.0.1:57049] OPTIONS /library/recentlyAdded (11 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG - Request: [127.0.0.1:57050] OPTIONS /channels/recentlyViewed?X-Plex-Container-Start=0&X-Plex-Container-Size=50 (11 live)
May 10, 2014 02:01:43 [0x10aba2000] DEBUG -  * X-Plex-Container-Start => 0
May 10, 2014 02:01:43 [0x10aba2000] DEBUG -  * X-Plex-Container-Size => 50
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Request: [127.0.0.1:57051] GET /clients (11 live)
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - It took 0.000018 sec to serialize a list with 0 elements.
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Request: [127.0.0.1:57052] GET /status/sessions (11 live)
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - [Now] Adding 0 sessions.
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - It took 0.000016 sec to serialize a list with 0 elements.
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Request: [127.0.0.1:57044] GET /:/websockets/notifications (10 live)
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Creating a WebSocket for notification stream
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - WebSocket: Performing handshake from origin http://plex.tv
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Beginning read from WebSocket
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Request: [127.0.0.1:57053] GET /:/prefs (11 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - Request: [127.0.0.1:57055] GET /servers (15 live)
May 10, 2014 02:01:44 [0x10ac25000] DEBUG - Request: [127.0.0.1:57056] GET /library/sections (15 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - It took 0.000027 sec to serialize a list with 1 elements.
May 10, 2014 02:01:44 [0x10ac25000] DEBUG - It took 0.000325 sec to serialize a list with 1 elements.
May 10, 2014 02:01:44 [0x10a893000] DEBUG - Request: [127.0.0.1:57057] GET /library/onDeck (14 live)
May 10, 2014 02:01:44 [0x10ac25000] DEBUG - Request: [127.0.0.1:57058] GET /library/recentlyAdded (13 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - It took 0.000011 sec to serialize a list with 0 elements.
May 10, 2014 02:01:44 [0x10a893000] DEBUG - Request: [127.0.0.1:57059] GET /channels/recentlyViewed?X-Plex-Container-Start=0&X-Plex-Container-Size=50 (12 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG -  * X-Plex-Container-Start => 0
May 10, 2014 02:01:44 [0x10a893000] DEBUG -  * X-Plex-Container-Size => 50
May 10, 2014 02:01:44 [0x10a893000] DEBUG - Setting container serialization range to [0, 49] (total=-1)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - It took 0.000047 sec to serialize a partial list with 3 elements (3 total).
May 10, 2014 02:01:44 [0x10ac25000] DEBUG - It took 0.000639 sec to serialize a list with 4 elements.
May 10, 2014 02:01:44 [0x10aba2000] DEBUG - Request: [192.168.0.101:57060] OPTIONS / (12 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - Request: [192.168.0.101:57061] GET / (12 live)
May 10, 2014 02:01:44 [0x10a893000] DEBUG - It took 0.000090 sec to serialize a list with 14 elements.
May 10, 2014 02:01:47 [0x10aba2000] DEBUG - Request: [127.0.0.1:57067] OPTIONS /library/metadata/1?checkFiles=1 (12 live)
May 10, 2014 02:01:47 [0x10aba2000] DEBUG -  * checkFiles => 1
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - Request: [127.0.0.1:57068] GET /library/metadata/1?checkFiles=1 (12 live)
May 10, 2014 02:01:47 [0x10ac25000] DEBUG -  * checkFiles => 1
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - Refreshing tokens inside the token-based authentication filter.
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - HTTP requesting to: https://plex.tv/servers/55cf7002929d6e3a7946084bfbe50520d5d0cc3f/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - MyPlex: Added 7 super-tokens.
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - Came in with a super-token, authorization succeeded.
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - It took 12.593000 ms to retrieve 216 items.
May 10, 2014 02:01:47 [0x10ac25000] DEBUG - It took 0.001881 sec to serialize a list with 1 elements.
May 10, 2014 02:01:50 [0x10aba2000] DEBUG - Request: [192.168.0.100:46547] OPTIONS /library/arts?sort=random&X-Plex-Container-Start=0&X-Plex-Container-Size=50 (12 live)
May 10, 2014 02:01:50 [0x10aba2000] DEBUG -  * sort => random
May 10, 2014 02:01:50 [0x10aba2000] DEBUG -  * X-Plex-Container-Start => 0
May 10, 2014 02:01:50 [0x10aba2000] DEBUG -  * X-Plex-Container-Size => 50
May 10, 2014 02:01:50 [0x10a893000] DEBUG - Request: [192.168.0.100:46549] GET /library/arts?sort=random&X-Plex-Container-Start=0&X-Plex-Container-Size=50 (12 live)
May 10, 2014 02:01:50 [0x10a893000] DEBUG -  * sort => random
May 10, 2014 02:01:50 [0x10a893000] DEBUG -  * X-Plex-Container-Start => 0
May 10, 2014 02:01:50 [0x10a893000] DEBUG -  * X-Plex-Container-Size => 50
May 10, 2014 02:01:50 [0x10a893000] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxxbd4-4fbd-adda-227522fc401b), enabling token-based authentication.
May 10, 2014 02:01:50 [0x10a893000] DEBUG - Refreshing tokens inside the token-based authentication filter.
May 10, 2014 02:01:50 [0x10a893000] DEBUG - HTTP requesting to: https://plex.tv/servers/55cf7002929d6e3a7946084bfbe50520d5d0cc3f/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - Request: [127.0.0.1:57072] OPTIONS /playQueues?uri=library%3A%2F%2Ff0a93e3d-6246-4db2-b6a8-21d6be079896%2Fitem%2F%252Flibrary%252Fmetadata%252F1&type=video&shuffle=0 (4 live)
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * uri => library://f0a93e3d-6246-4db2-b6a8-21d6be079896/item/%2Flibrary%2Fmetadata%2F1
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * type => video
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * shuffle => 0
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - Request: [127.0.0.1:57073] POST /playQueues?uri=library%3A%2F%2Ff0a93e3d-6246-4db2-b6a8-21d6be079896%2Fitem%2F%252Flibrary%252Fmetadata%252F1&type=video&shuffle=0 (4 live)
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * uri => library://f0a93e3d-6246-4db2-b6a8-21d6be079896/item/%2Flibrary%2Fmetadata%2F1
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * type => video
May 10, 2014 02:01:52 [0x10aba2000] DEBUG -  * shuffle => 0
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 10, 2014 02:01:52 [0x10a893000] DEBUG - MyPlex: Added 7 super-tokens.
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - Came in with a super-token, authorization succeeded.
May 10, 2014 02:01:52 [0x10a893000] DEBUG - Setting container serialization range to [0, 49] (total=-1)
May 10, 2014 02:01:52 [0x10a893000] DEBUG - It took 0.000079 sec to serialize a partial list with 4 elements (4 total).
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - PlayQueue: Start index: 0 End index: 0 Count: 1
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - PlayQueue: 1 generated IDs compressed down to a 24 byte blob.
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - PlayQueue: Added 1 items in 0.0 sec.
May 10, 2014 02:01:52 [0x10aba2000] DEBUG - It took 0.000775 sec to serialize a list with 1 elements.