Hacking Crash WiiU via browser. Exploitable?

  • Thread starter Thread starter ChrisX930
  • Start date Start date
  • Views Views 67,241
  • Replies Replies 267
  • Likes Likes 6
Status
Not open for further replies.
As I've said before, it's very very important that someone finds out how Plex is handling the video - what container format and stream formats are being used. You guys are running in circles without that information.
 
As I've said before, it's very very important that someone finds out how Plex is handling the video - what container format and stream formats are being used. You guys are running in circles without that information.



Why? Can't we just cause the crash via plex, (and if it works out) run the exploit?
 
Why? Can't we just cause the crash via plex, (and if it works out) run the exploit?
There's no reason to use Plex to invoke the bug when it's not necessary. Plus transcoding either stream might ruin exploit data, since that's a reasonable place to store it.
 
Why? Can't we just cause the crash via plex, (and if it works out) run the exploit?


But how do you get it to run an exploit, if we don't even really know how or why this is occurring through Plex? You can't just throw code at something that crashes the Wii U and assume the whole thing will then be hacked.
 
Why? Can't we just cause the crash via plex, (and if it works out) run the exploit?

Because plex is fatty and if we can trim out the fat to make a streaming program that's sole purpose is to exploit the wii u browser it'll be a lot easier for end users to run the crash. Still, we need to actually figure out if this is actually exploitable.
 
I mean, if you or someone else wants to look into it more, there's a few ways you can do it. Try seeing if Plex is transcoding the media, and if so what streams are being transcoded into what, and what streams are just being remuxed. Then you should be able to create your own crash file without having to use Plex. That helps with finding the reason it's crashing, if only just the tiniest bit. Still not much you can do from that front though. There's lower-level stuff we'd like to try in order to to diagnose what's causing this bug and if it's exploitable, but I'd have Marionumber1 explain that if he feels like it.

Plex doesn't transcode UFT8 or M38U. It simply places it without change. Even with transcode enabled, its a problem with the encode in addition to other problems. I'm not sure of the exact problem but I hope to narrow it down by excluding misc crap by creating files during the week. I think it may have to do with the reference frames but I'm not positive. At this point, it could be the OGG audio in the file which is non-standard as well.

For sake of version testing, I've gotten it to crash on 9.9.16 which is the most recent plex pass build. Which is more recent than you thieving free users ;)
 
Plex doesn't transcode UFT8 or M38U. It simply places it without change. Even with transcode enabled, its a problem with the encode in addition to other problems. I'm not sure of the exact problem but I hope to narrow it down by excluding misc crap by creating files during the week. I think it may have to do with the reference frames but I'm not positive. At this point, it could be the OGG audio in the file which is non-standard as well.

For sake of version testing, I've gotten it to crash on 9.9.16 which is the most recent plex pass build. Which is more recent than you thieving free users ;)

What are UFT8 and M38U? I'm asking about the container format (avi, mp4, etc), stream format for video (h.264, m-jpeg, etc), and stream format for audio (AAC, AC3, etc). As in: what's being sent to the console, not what the mkv has itself.
 
What are UFT8 and M38U? I'm asking about the container format (avi, mp4, etc), stream format for video (h.264, m-jpeg, etc), and stream format for audio (AAC, AC3, etc). As in: what's being sent to the console, not what the mkv has itself.

UFT8 (i believe, it may be a typo in the bleeding edge version of mpc for utf8) is a text handler in mpeg4 video. M3U8 (sorry that was a typo before, after drinking I'm mostly trashed) is the streaming mp4 format that all video is streamed through over the interwebs. Containers are irrelevant when it comes to transcoding which strips that away anyway.

[edit] all video that maintains chapters and seeking anyway
 
Apparently the Wii U WebKit browser does not support the HTML5 video tag. I'll try to throw together a basic node/ffmpeg streaming server and see if I can reproduce the crash without Plex.

If you do have Plex and want to upload some logs from the locations posted on the previous page that should help in figuring out what's going on.
 
I have had this sorta thing happen pretty often. i go to my usual streaming sites, even happens with hulu at times. like i finish a video and then press home or try to power off and it'll freeze, and force an unplug to reset. could this be the same thing?
 
I have had this sorta thing happen pretty often. i go to my usual streaming sites, even happens with hulu at times. like i finish a video and then press home or try to power off and it'll freeze, and force an unplug to reset. could this be the same thing?

yes, I thinks it could be the same thing.

EDIT: I uploaded the Logs from today.

Aug 31, 2014 10:20:08:007 [8500] INFO - LANGID = 0x407
Aug 31, 2014 10:20:08:007 [8500] INFO - Windows version 6.1 (Build 7601)
Aug 31, 2014 10:20:08:007 [8500] INFO - 4 2411 MHz processor(s): Architecture=0, Level=16, Revision=515
Aug 31, 2014 10:20:08:007 [8500] INFO - PROCESSOR_IDENTIFIER=AMD64 Family 16 Model 2 Stepping 3, AuthenticAMD
Aug 31, 2014 10:20:08:018 [8500] INFO - Plex Media Server v0.9.9.14.531-7eef8c6 - Microsoft PC
Aug 31, 2014 10:20:08:018 [8500] DEBUG - Opening 20 database sessions to library, SQLite 3.8.5, threadsafe=1
Aug 31, 2014 10:20:08:032 [8500] INFO - SQLITE3:94cf909, 283, recovered 239 frames from WAL file C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Aug 31, 2014 10:20:08:074 [8500] DEBUG - Running migrations.
Aug 31, 2014 10:20:09:259 [8500] DEBUG - Listening on port 32400 with queue of 2147483647 connections.
Aug 31, 2014 10:20:09:260 [8500] DEBUG - Listening on port 32401 with queue of 2147483647 connections.
Aug 31, 2014 10:20:09:308 [8500] DEBUG - Adding directory for site configurations: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources
Aug 31, 2014 10:20:09:308 [8500] DEBUG - The path changed: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources.
Aug 31, 2014 10:20:09:308 [8500] DEBUG - This corresponds to site configuration map: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources (directory: 1)
Aug 31, 2014 10:20:09:308 [8500] DEBUG - Adding directory for site configurations: C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations
Aug 31, 2014 10:20:09:308 [8500] DEBUG - The path changed: C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations.
Aug 31, 2014 10:20:09:308 [8500] DEBUG - This corresponds to site configuration map: C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations (directory: 1)
Aug 31, 2014 10:20:09:309 [0300] DEBUG - File C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources changed: -1 => -1.
Aug 31, 2014 10:20:09:309 [0300] DEBUG - File C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations changed: -1 => -1.
Aug 31, 2014 10:20:09:309 [0300] DEBUG - The path changed: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources.
Aug 31, 2014 10:20:09:309 [0300] DEBUG - This corresponds to site configuration map: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins/SiteConfigurations.bundle/Contents/Resources (directory: 1)
Aug 31, 2014 10:20:09:309 [0300] DEBUG - The path changed: C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations.
Aug 31, 2014 10:20:09:309 [0300] DEBUG - This corresponds to site configuration map: C:\Users\USERNAME\AppData\Local\Plex Media Server\Site Configurations (directory: 1)
Aug 31, 2014 10:20:09:958 [0120] DEBUG - WebKit supports Flash content
Aug 31, 2014 10:20:09:958 [0120] DEBUG - WebKit supports Silverlight content
Aug 31, 2014 10:20:09:958 [0120] INFO - Successfully initialized WebKit
Aug 31, 2014 10:20:10:055 [8500] DEBUG - Setting up scheduled updates
Aug 31, 2014 10:20:10:055 [8500] INFO - LibraryUpdateManager path watching is disabled
Aug 31, 2014 10:20:10:056 [5940] DEBUG - Starting scheduled updates, every 900 seconds
Aug 31, 2014 10:20:11:192 [3496] DEBUG - File C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins changed: -1 => -1.
Aug 31, 2014 10:20:11:193 [3496] DEBUG - Scanning for plug-ins in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins
Aug 31, 2014 10:20:11:194 [3496] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\System.bundle.
Aug 31, 2014 10:20:11:219 [3496] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Aug 31, 2014 10:20:11:278 [3496] DEBUG - Starting file watcher for com.plexapp.system
Aug 31, 2014 10:20:11:278 [3496] DEBUG - Plugin::createProcess: Creating plugin process: "C:\Program Files (x86)\Plex\Plex Media Server\PlexScriptHost.exe" "C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Framework.bundle\Contents\Resources\Versions\2\Python/bootstrap.py" "C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\System.bundle"
Aug 31, 2014 10:20:11:305 [3496] DEBUG - Spawned plug-in com.plexapp.system with PID 8756
Aug 31, 2014 10:20:11:305 [3496] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes

Aug 31, 2014 10:20:13:074 [7148] DEBUG - Crash Reporter: Starting up.
Aug 31, 2014 10:20:24:982 [3496] DEBUG - Reading 486 bytes in the body, code is 200
Aug 31, 2014 10:20:24:982 [3496] DEBUG - [com.plexapp.system] Plug-in running on port 28057.
Aug 31, 2014 10:20:24:982 [3496] DEBUG - * Plug-in handles prefix: /system
Aug 31, 2014 10:20:24:982 [3496] DEBUG - * Plug-in handles prefix: /player
Aug 31, 2014 10:20:24:982 [3496] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Aug 31, 2014 10:20:25:053 [3496] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Aug 31, 2014 10:20:25:053 [3496] DEBUG - Updating the list of agents known by the system.
Aug 31, 2014 10:20:25:053 [3496] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Aug 31, 2014 10:20:25:054 [8500] DEBUG - Image transcode cache directory: C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder
Aug 31, 2014 10:20:25:054 [3496] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/agents
Aug 31, 2014 10:20:25:089 [8500] DEBUG - Cleaning old transcode directories.
Aug 31, 2014 10:20:25:110 [8500] DEBUG - NAT: Starting Mapping Thread.
Aug 31, 2014 10:20:25:110 [8500] DEBUG - NAT: Using previously obtained port of 1758.
Aug 31, 2014 10:20:25:111 [8500] DEBUG - NAT: Creating NAT puncher thread 04C7C7F0
Aug 31, 2014 10:20:25:111 [8500] DEBUG - Creating NetworkServices singleton.
Aug 31, 2014 10:20:25:111 [8500] DEBUG - NetworkServices: Initializing...
Aug 31, 2014 10:20:25:111 [8500] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:20:25:111 [8244] DEBUG - NAT: Updating mapping in puncher thread 04C7C7F0
Aug 31, 2014 10:20:25:111 [8244] DEBUG - NAT: Creating puncher.
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Switching to NAT-PMP strategy.
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Creating NATPmPPuncher.
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Initializing NAT-PMP, success=1
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Finding public address failed the first way, switching.
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Switching to UPnP strategy.
Aug 31, 2014 10:20:25:112 [8244] DEBUG - NAT: Creating NATUPnPPuncher.
Aug 31, 2014 10:20:25:138 [8500] DEBUG - Network interfaces:
Aug 31, 2014 10:20:25:138 [8500] DEBUG - * 1 {846EE342-7039-11DE-9D20-806E6F6E6963} (127.0.0.1) (loopback: 1)
Aug 31, 2014 10:20:25:139 [8500] DEBUG - * 11 {B5A6D598-4586-4649-BAA5-929BAE060E79} (192.168.0.100) (loopback: 0)
Aug 31, 2014 10:20:25:139 [8500] DEBUG - * 14 {EDBAA5E4-CD97-4B64-9A25-2FA1A7043DB6} (192.168.56.1) (loopback: 0)
Aug 31, 2014 10:20:25:139 [8500] DEBUG - * 16 {813FE589-51E1-4D5B-9656-357EDAA904F4} (25.108.105.229) (loopback: 0)
Aug 31, 2014 10:20:25:140 [8500] DEBUG - 04CB46E0: Creating new Network Service and registering for notifications.
Aug 31, 2014 10:20:25:140 [8500] DEBUG - 04CB46E0: NetworkService got notification of changed network (first change: 1)
Aug 31, 2014 10:20:25:141 [8500] DEBUG - NetworkService: Quick dispatch of network change.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CA1D10: Creating new Network Service and registering for notifications.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CA1D10: NetworkService got notification of changed network (first change: 1)
Aug 31, 2014 10:20:25:141 [8500] DEBUG - NetworkService: Quick dispatch of network change.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CA3D50: Creating new Network Service and registering for notifications.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CA3D50: NetworkService got notification of changed network (first change: 1)
Aug 31, 2014 10:20:25:141 [8500] DEBUG - NetworkService: Quick dispatch of network change.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CC5F00: Creating new Network Service and registering for notifications.
Aug 31, 2014 10:20:25:141 [8500] DEBUG - 04CC5F00: NetworkService got notification of changed network (first change: 1)
Aug 31, 2014 10:20:25:142 [8500] DEBUG - NetworkService: Quick dispatch of network change.
Aug 31, 2014 10:20:25:142 [8856] DEBUG - Network change for advertiser.
Aug 31, 2014 10:20:25:142 [8500] DEBUG - Starting HTTP server.
Aug 31, 2014 10:20:25:143 [8500] DEBUG - Running server...
Aug 31, 2014 10:20:25:143 [8856] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414 (outbound: 0)
Aug 31, 2014 10:20:25:143 [8500] DEBUG - Waiting for server condition to be signaled.
Aug 31, 2014 10:20:25:143 [8308] DEBUG - DLNA server starting.
Aug 31, 2014 10:20:25:143 [8308] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\PlexDlnaServer.exe
Aug 31, 2014 10:20:25:143 [4308] DEBUG - Set up a thread pool for HTTP server with 2 threads.
Aug 31, 2014 10:20:25:144 [4308] DEBUG - Running database fix-ups.
Aug 31, 2014 10:20:25:144 [8856] DEBUG - Network change for advertiser.
Aug 31, 2014 10:20:25:144 [8856] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410 (outbound: 0)
Aug 31, 2014 10:20:25:145 [8856] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Aug 31, 2014 10:20:25:145 [8856] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413 (outbound: 0)
Aug 31, 2014 10:20:25:145 [8856] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Aug 31, 2014 10:20:25:146 [4308] DEBUG - Database Fixups: Destroyed 0 transient items.
Aug 31, 2014 10:20:25:146 [8856] DEBUG - NetworkService: Browsing on interface 192.168.0.100 on broadcast address 192.168.0.255 (index: 1)
Aug 31, 2014 10:20:25:146 [8856] DEBUG - NetworkService: Browsing on interface 192.168.56.1 on broadcast address 192.168.56.255 (index: 2)
Aug 31, 2014 10:20:25:146 [8856] DEBUG - NetworkService: Browsing on interface 25.108.105.229 on broadcast address 25.255.255.255 (index: 3)
Aug 31, 2014 10:20:25:147 [8856] DEBUG - NetworkService: Network change for browser (polled=1), closing 0 browse sockets.
Aug 31, 2014 10:20:25:147 [8856] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Aug 31, 2014 10:20:25:147 [8856] DEBUG - NetworkService: Browsing on interface 192.168.0.100 on broadcast address 192.168.0.255 (index: 1)
Aug 31, 2014 10:20:25:148 [8856] DEBUG - NetworkService: Browsing on interface 192.168.56.1 on broadcast address 192.168.56.255 (index: 2)
Aug 31, 2014 10:20:25:148 [8856] DEBUG - NetworkService: Browsing on interface 25.108.105.229 on broadcast address 25.255.255.255 (index: 3)
Aug 31, 2014 10:20:25:153 [8856] DEBUG - NetworkServiceBrowser: SERVER arrived: 192.168.0.100 (USERNAME Streaming)
Aug 31, 2014 10:20:25:153 [8856] DEBUG - Notifying the system bundle an update to server /system/notify/serverUpdated?host=192.168.0.100
Aug 31, 2014 10:20:25:153 [8856] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/notify/serverUpdated?host=192.168.0.100
Aug 31, 2014 10:20:25:154 [8856] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/notify/serverUpdated?host=192.168.0.100
Aug 31, 2014 10:20:25:208 [5976] DEBUG - Request: [127.0.0.1:28053] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (4 live)
Aug 31, 2014 10:20:25:209 [5976] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Aug 31, 2014 10:20:25:209 [7724] DEBUG - Request: [127.0.0.1:28055] GET / (6 live)
Aug 31, 2014 10:20:25:210 [1224] DEBUG - Request: [127.0.0.1:28054] GET / (6 live)
Aug 31, 2014 10:20:25:210 [5976] DEBUG - HTTP requesting to: http://127.0.0.1:28057/:/plugins/co...Cmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Aug 31, 2014 10:20:25:210 [7724] DEBUG - It took 0.000000 sec to serialize a list with 11 elements.
Aug 31, 2014 10:20:25:211 [1224] DEBUG - It took 0.001000 sec to serialize a list with 11 elements.
Aug 31, 2014 10:20:25:211 [8576] DEBUG - Request: [127.0.0.1:28056] GET /servers (6 live)
Aug 31, 2014 10:20:25:212 [8576] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:25:213 [8496] DEBUG - Request: [127.0.0.1:28062] GET /servers (6 live)
Aug 31, 2014 10:20:25:213 [8496] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:25:256 [7724] DEBUG - Request: [127.0.0.1:28064] GET / (6 live)
Aug 31, 2014 10:20:25:257 [7724] DEBUG - It took 0.000000 sec to serialize a list with 11 elements.
Aug 31, 2014 10:20:25:263 [1224] DEBUG - Request: [192.168.0.100:28065] GET /library/sections (6 live)
Aug 31, 2014 10:20:25:275 [8576] DEBUG - Request: [192.168.0.100:28066] GET /library/sections (6 live)
Aug 31, 2014 10:20:25:333 [8576] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:25:333 [1224] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:25:345 [7724] DEBUG - Request: [192.168.0.100:28067] GET /channels/all (6 live)
Aug 31, 2014 10:20:25:346 [8496] DEBUG - Request: [192.168.0.100:28068] GET /channels/all (6 live)
Aug 31, 2014 10:20:25:346 [7724] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:20:25:347 [8496] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:20:25:361 [8856] DEBUG - [com.plexapp.system] HTTP reply status 200, with 0 bytes of content.
Aug 31, 2014 10:20:28:146 [7148] DEBUG - Device: Microsoft PC
Aug 31, 2014 10:20:28:383 [8244] DEBUG - NAT: Initialized UPnP, result: SUCCESS
Aug 31, 2014 10:20:28:444 [8244] DEBUG - NAT: Requested public address via UPnP (success=1)
Aug 31, 2014 10:20:28:444 [8244] DEBUG - NAT: Obtained public address of xx.xxx.80.228 (failed: 0 myPlex: 0).
Aug 31, 2014 10:20:28:444 [8244] DEBUG - NAT: Checking for change in address: old was and new is xx.xxx.80.228.
Aug 31, 2014 10:20:28:524 [8244] DEBUG - NAT: Unmapped port via UPnP.
Aug 31, 2014 10:20:28:738 [8244] DEBUG - NAT: Added mapping via UPnP, Public Side => xx.xxx.80.228:1758 (TCP), Private Side => 192.168.0.100:32400
Aug 31, 2014 10:20:28:738 [8244] INFO - NAT: Mapping changed xx.xxx.80.228:1758 -> 192.168.0.100:32400
Aug 31, 2014 10:20:28:738 [8244] DEBUG - MyPlex: Updating device connections.
Aug 31, 2014 10:20:28:738 [8244] DEBUG - NAT: Updating mapping complete in thread 04C7C7F0.
Aug 31, 2014 10:20:28:738 [8244] DEBUG - NAT: Deleting puncher.
Aug 31, 2014 10:20:28:738 [8244] DEBUG - NAT: Deleting NATUPnPPuncher.
Aug 31, 2014 10:20:28:738 [8244] DEBUG - NAT: Deleting NATPmPPuncher.
Aug 31, 2014 10:20:28:776 [8244] DEBUG - NAT: We're going to next poll in 19.0 hours.
Aug 31, 2014 10:20:40:004 [6760] DEBUG - Request: [192.168.0.1:2930] GET /web/index.html (3 live)
Aug 31, 2014 10:20:40:029 [6760] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\index.html
Aug 31, 2014 10:20:40:055 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\index.html is 2444.
Aug 31, 2014 10:20:40:123 [8736] DEBUG - Request: [192.168.0.1:2931] GET /web/css/main-desktop.css?hash=b35eae1 (5 live)
Aug 31, 2014 10:20:40:123 [8736] DEBUG - * hash => b35eae1
Aug 31, 2014 10:20:40:123 [8736] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\css\main-desktop.css
Aug 31, 2014 10:20:40:138 [7640] DEBUG - Request: [192.168.0.1:2932] GET /web/js/plex.js?hash=b35eae1&version=2.2.4 (5 live)
Aug 31, 2014 10:20:40:138 [7640] DEBUG - * hash => b35eae1
Aug 31, 2014 10:20:40:138 [7640] DEBUG - * version => 2.2.4
Aug 31, 2014 10:20:40:139 [7640] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\js\plex.js
Aug 31, 2014 10:20:40:139 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\css\main-desktop.css is 264031.
Aug 31, 2014 10:20:40:140 [7640] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\js\plex.js is 1708144.
Aug 31, 2014 10:20:40:813 [6760] DEBUG - Request: [192.168.0.1:2933] GET /web/img/plex-logo.svg (5 live)
Aug 31, 2014 10:20:40:814 [6760] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\img\plex-logo.svg
Aug 31, 2014 10:20:40:875 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\img\plex-logo.svg is 2255.
Aug 31, 2014 10:20:43:127 [8736] DEBUG - Request: [192.168.0.1:2934] GET /web/fonts/opensans-regular-webfont.woff (5 live)
Aug 31, 2014 10:20:43:127 [8736] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\opensans-regular-webfont.woff
Aug 31, 2014 10:20:43:140 [7640] DEBUG - Request: [192.168.0.1:2935] GET /web/translations/de.json (5 live)
Aug 31, 2014 10:20:43:153 [7072] DEBUG - Request: [192.168.0.1:2936] GET /web/fonts/glyphicons-regular.woff (6 live)
Aug 31, 2014 10:20:43:187 [7640] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\translations\de.json
Aug 31, 2014 10:20:43:187 [7072] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\glyphicons-regular.woff
Aug 31, 2014 10:20:43:226 [7640] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\translations\de.json is 59774.
Aug 31, 2014 10:20:43:287 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\opensans-regular-webfont.woff is 24708.
Aug 31, 2014 10:20:43:287 [7072] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\glyphicons-regular.woff is 96044.
Aug 31, 2014 10:20:43:877 [7640] DEBUG - Request: [192.168.0.1:2938] GET /?X-Plex-Client-Identifier=n9r0fg2s18&X-Plex-Product=Plex+Web&X-Plex-Device=Unknown+Platform&X-Plex-Platform=Wii+U&X-Plex-Platform-Version=0&X-Plex-Version=2.2.4&X-Plex-Device-Name=Plex+Web+(Wii+U) (6 live)
Aug 31, 2014 10:20:43:877 [7640] DEBUG - * X-Plex-Client-Identifier => n9r0fg2s18
Aug 31, 2014 10:20:43:877 [7640] DEBUG - * X-Plex-Product => Plex Web
Aug 31, 2014 10:20:43:877 [7640] DEBUG - * X-Plex-Device => Unknown Platform
Aug 31, 2014 10:20:43:877 [7640] DEBUG - * X-Plex-Platform => Wii U
Aug 31, 2014 10:20:43:877 [7640] DEBUG - * X-Plex-Platform-Version => 0
Aug 31, 2014 10:20:43:878 [7640] DEBUG - * X-Plex-Version => 2.2.4
Aug 31, 2014 10:20:43:878 [7640] DEBUG - * X-Plex-Device-Name => Plex Web (Wii U)
Aug 31, 2014 10:20:43:879 [7640] DEBUG - It took 0.000000 sec to serialize a list with 11 elements.
Aug 31, 2014 10:20:44:210 [8736] DEBUG - Request: [192.168.0.1:2939] GET /web/favicon.ico (9 live)
Aug 31, 2014 10:20:44:211 [8736] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\favicon.ico
Aug 31, 2014 10:20:44:212 [6760] DEBUG - Request: [192.168.0.1:2940] GET /library/metadata/2185?checkFiles=1&includeExtras=1 (8 live)
Aug 31, 2014 10:20:44:212 [6760] DEBUG - * checkFiles => 1
Aug 31, 2014 10:20:44:212 [6760] DEBUG - * includeExtras => 1
Aug 31, 2014 10:20:44:212 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\favicon.ico is 5430.
Aug 31, 2014 10:20:44:213 [7640] DEBUG - Request: [192.168.0.1:2941] GET /clients (7 live)
Aug 31, 2014 10:20:44:214 [7640] DEBUG - It took 0.001000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:20:44:298 [7072] DEBUG - Request: [192.168.0.1:2942] GET /:/websockets/notifications (6 live)
Aug 31, 2014 10:20:44:299 [7072] DEBUG - Creating a WebSocket for notification stream for account 1
Aug 31, 2014 10:20:44:299 [7072] DEBUG - WebSocket: Performing handshake from origin http://xx.xxx.80.228:32400
Aug 31, 2014 10:20:44:299 [7072] DEBUG - Beginning read from WebSocket
Aug 31, 2014 10:20:44:365 [7072] DEBUG - Request: [192.168.0.1:2943] GET /status/sessions (8 live)
Aug 31, 2014 10:20:44:377 [8736] DEBUG - Request: [192.168.0.1:2944] GET /system/appstore/history?X-Plex-Container-Start=0&X-Plex-Container-Size=1 (7 live)
Aug 31, 2014 10:20:44:377 [8736] DEBUG - * X-Plex-Container-Start => 0
Aug 31, 2014 10:20:44:377 [8736] DEBUG - * X-Plex-Container-Size => 1
Aug 31, 2014 10:20:44:377 [8736] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/appstore/history
Aug 31, 2014 10:20:44:378 [8736] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/appstore/history
Aug 31, 2014 10:20:44:394 [8736] DEBUG - [com.plexapp.system] HTTP reply status 200, with 594 bytes of content.
Aug 31, 2014 10:20:44:609 [7072] DEBUG - Request: [192.168.0.1:2946] GET /:/prefs (7 live)
Aug 31, 2014 10:20:44:614 [7640] DEBUG - Request: [192.168.0.1:2948] GET /servers (7 live)
Aug 31, 2014 10:20:44:615 [7640] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:44:811 [7640] DEBUG - Request: [192.168.0.105:2949] GET /?X-Plex-Client-Identifier=n9r0fg2s18&X-Plex-Product=Plex+Web&X-Plex-Device=Unknown+Platform&X-Plex-Platform=Wii+U&X-Plex-Platform-Version=0&X-Plex-Version=2.2.4&X-Plex-Device-Name=Plex+Web+(Wii+U) (7 live)
Aug 31, 2014 10:20:44:811 [7640] DEBUG - * X-Plex-Client-Identifier => n9r0fg2s18
Aug 31, 2014 10:20:44:811 [7640] DEBUG - * X-Plex-Product => Plex Web
Aug 31, 2014 10:20:44:811 [7640] DEBUG - * X-Plex-Device => Unknown Platform
Aug 31, 2014 10:20:44:811 [7640] DEBUG - * X-Plex-Platform => Wii U
Aug 31, 2014 10:20:44:812 [7640] DEBUG - * X-Plex-Platform-Version => 0
Aug 31, 2014 10:20:44:812 [7640] DEBUG - * X-Plex-Version => 2.2.4
Aug 31, 2014 10:20:44:812 [7640] DEBUG - * X-Plex-Device-Name => Plex Web (Wii U)
Aug 31, 2014 10:20:44:813 [7640] DEBUG - It took 0.000000 sec to serialize a list with 11 elements.
Aug 31, 2014 10:20:52:649 [8736] DEBUG - Request: [192.168.0.105:2952] OPTIONS /library/sections (10 live)
Aug 31, 2014 10:20:52:651 [7640] DEBUG - Request: [192.168.0.105:2953] OPTIONS /library/onDeck (9 live)
Aug 31, 2014 10:20:52:653 [7072] DEBUG - Request: [192.168.0.105:2954] OPTIONS /library/recentlyAdded (8 live)
Aug 31, 2014 10:20:52:658 [6760] DEBUG - Request: [192.168.0.105:2955] OPTIONS /channels/recentlyViewed?X-Plex-Container-Start=0&X-Plex-Container-Size=50 (7 live)
Aug 31, 2014 10:20:52:658 [6760] DEBUG - * X-Plex-Container-Start => 0
Aug 31, 2014 10:20:52:658 [6760] DEBUG - * X-Plex-Container-Size => 50
Aug 31, 2014 10:20:52:686 [8736] DEBUG - Request: [192.168.0.1:2956] GET /web/fonts/opensans-bold-webfont.woff (10 live)
Aug 31, 2014 10:20:52:687 [8736] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\opensans-bold-webfont.woff
Aug 31, 2014 10:20:52:689 [6760] DEBUG - Request: [192.168.0.1:2957] GET /web/fonts/plex-icons.woff (9 live)
Aug 31, 2014 10:20:52:690 [6760] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\plex-icons.woff
Aug 31, 2014 10:20:52:691 [7640] DEBUG - Request: [192.168.0.105:2959] GET /library/onDeck (8 live)
Aug 31, 2014 10:20:52:691 [8544] DEBUG - Request: [192.168.0.105:2958] GET /library/sections (8 live)
Aug 31, 2014 10:20:52:693 [8544] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:52:697 [7640] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:20:52:704 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\plex-icons.woff is 1764.
Aug 31, 2014 10:20:52:705 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\fonts\opensans-bold-webfont.woff is 25512.
Aug 31, 2014 10:20:52:849 [7072] DEBUG - Request: [192.168.0.105:2960] GET /library/recentlyAdded (8 live)
Aug 31, 2014 10:20:52:858 [7640] DEBUG - Request: [192.168.0.105:2961] GET /channels/recentlyViewed?X-Plex-Container-Start=0&X-Plex-Container-Size=50 (8 live)
Aug 31, 2014 10:20:52:858 [7640] DEBUG - * X-Plex-Container-Start => 0
Aug 31, 2014 10:20:52:858 [7640] DEBUG - * X-Plex-Container-Size => 50
Aug 31, 2014 10:20:52:859 [7072] DEBUG - It took 0.002000 sec to serialize a list with 3 elements.
Aug 31, 2014 10:20:52:860 [7640] DEBUG - Setting container serialization range to [0, 49] (total=-1)
Aug 31, 2014 10:20:52:860 [7640] DEBUG - It took 0.000000 sec to serialize a partial list with 0 elements (0 total).
Aug 31, 2014 10:20:53:249 [6760] DEBUG - Request: [192.168.0.105:2962] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2470%2Fthumb%2F1409406706&width=300&height=450&minSize=1 (10 live)
Aug 31, 2014 10:20:53:249 [6760] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2470/thumb/1409406706
Aug 31, 2014 10:20:53:249 [6760] DEBUG - * width => 300
Aug 31, 2014 10:20:53:249 [6760] DEBUG - * height => 450
Aug 31, 2014 10:20:53:250 [6760] DEBUG - * minSize => 1
Aug 31, 2014 10:20:53:251 [7640] DEBUG - Request: [192.168.0.105:2963] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2469%2Fthumb%2F1409386928&width=300&height=450&minSize=1 (9 live)
Aug 31, 2014 10:20:53:251 [7640] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2469/thumb/1409386928
Aug 31, 2014 10:20:53:251 [7640] DEBUG - * width => 300
Aug 31, 2014 10:20:53:251 [7640] DEBUG - * height => 450
Aug 31, 2014 10:20:53:251 [7640] DEBUG - * minSize => 1
Aug 31, 2014 10:20:53:252 [8544] DEBUG - Request: [192.168.0.105:2964] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468%2Fthumb%2F1409417948&width=300&height=450&minSize=1 (8 live)
Aug 31, 2014 10:20:53:253 [8544] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948
Aug 31, 2014 10:20:53:253 [8544] DEBUG - * width => 300
Aug 31, 2014 10:20:53:253 [8544] DEBUG - * height => 450
Aug 31, 2014 10:20:53:253 [8544] DEBUG - * minSize => 1
Aug 31, 2014 10:20:53:259 [6760] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2470/thumb/1409406706] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:53:260 [7640] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2469/thumb/1409386928] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:53:260 [8544] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:53:457 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\78\78de03604247296a8152b11fbbe51d200d7144a6.jpg is 6778.
Aug 31, 2014 10:20:53:464 [7640] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\35\359f8e40660e90e6bd47800e3ffe9b1327494f8b.jpg is 39074.
Aug 31, 2014 10:20:53:623 [8544] DEBUG - The cache file did not exist, but the original did [C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\dd\dd4fd3580e56ea5416940e2bc686346dd5a4c4c5.jpg].
Aug 31, 2014 10:20:53:883 [8544] DEBUG - Created thumbnail of size 341x450, has pixels: 1
Aug 31, 2014 10:20:53:993 [7072] DEBUG - Request: [192.168.0.105:2965] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468%2Fthumb%2F1409417948&width=300&height=450&minSize=1 (8 live)
Aug 31, 2014 10:20:53:994 [7072] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948
Aug 31, 2014 10:20:53:994 [7072] DEBUG - * width => 300
Aug 31, 2014 10:20:53:994 [7072] DEBUG - * height => 450
Aug 31, 2014 10:20:53:994 [7072] DEBUG - * minSize => 1
Aug 31, 2014 10:20:53:994 [7072] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:53:995 [7072] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\64\6436bfb0b66ec39a72afd6336fa93f8876940971.jpg is 51333.
Aug 31, 2014 10:20:54:914 [8736] DEBUG - Request: [192.168.0.105:2966] OPTIONS /library/metadata/2468?checkFiles=1&includeExtras=1 (8 live)
Aug 31, 2014 10:20:54:914 [8736] DEBUG - * checkFiles => 1
Aug 31, 2014 10:20:54:914 [8736] DEBUG - * includeExtras => 1
Aug 31, 2014 10:20:54:944 [7072] DEBUG - Request: [192.168.0.105:2967] GET /library/metadata/2468?checkFiles=1&includeExtras=1 (8 live)
Aug 31, 2014 10:20:54:944 [7072] DEBUG - * checkFiles => 1
Aug 31, 2014 10:20:54:944 [7072] DEBUG - * includeExtras => 1
Aug 31, 2014 10:20:54:956 [7072] DEBUG - Last refresh (2014-08-30 18:59:08) appears to be older than directory change time (2014-08-30 22:07:41), need to refresh local media agent.
Aug 31, 2014 10:20:54:956 [7072] DEBUG - Refreshing GUID: 'com.plexapp.agents.imdb://tt0375679?lang=en'
Aug 31, 2014 10:20:54:957 [7072] DEBUG - HTTP requesting to: http://127.0.0.1:32400/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:54:958 [8736] DEBUG - Request: [127.0.0.1:28165] GET /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0 (8 live)
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * mediaType => 1
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * force => 1
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * guid => com.plexapp.agents.imdb://tt0375679?lang=en
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * id => 2468
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * agent => com.plexapp.agents.localmedia
Aug 31, 2014 10:20:54:959 [8736] DEBUG - * async => 0
Aug 31, 2014 10:20:54:959 [8736] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:54:960 [8736] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:54:971 [7640] DEBUG - Request: [127.0.0.1:28167] GET /:/plugins (8 live)
Aug 31, 2014 10:20:54:972 [7640] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:54:979 [8736] DEBUG - [com.plexapp.system] HTTP reply status 200, with 99 bytes of content.
Aug 31, 2014 10:20:54:980 [7072] ERROR - Error response for update: 2 (Agent not found).
Aug 31, 2014 10:20:55:029 [7072] DEBUG - It took 0.003000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:55:275 [7996] DEBUG - Network change.
Aug 31, 2014 10:20:55:275 [7996] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:20:55:310 [7996] DEBUG - Network change notification but nothing changed.
Aug 31, 2014 10:20:55:575 [7640] DEBUG - Request: [192.168.0.105:2969] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468%2Fart%2F1409417948&width=2560&height=1440 (11 live)
Aug 31, 2014 10:20:55:575 [7640] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2468/art/1409417948
Aug 31, 2014 10:20:55:575 [7640] DEBUG - * width => 2560
Aug 31, 2014 10:20:55:575 [7640] DEBUG - * height => 1440
Aug 31, 2014 10:20:55:576 [7640] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2468/art/1409417948] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:55:577 [7072] DEBUG - Request: [192.168.0.1:2968] GET /web/img/blank.png (9 live)
Aug 31, 2014 10:20:55:577 [8736] DEBUG - Request: [192.168.0.105:2970] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468%2Fthumb%2F1409417948&width=500&height=750&minSize=1 (9 live)
Aug 31, 2014 10:20:55:577 [8736] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948
Aug 31, 2014 10:20:55:577 [8736] DEBUG - * width => 500
Aug 31, 2014 10:20:55:577 [8736] DEBUG - * height => 750
Aug 31, 2014 10:20:55:577 [6760] DEBUG - Request: [192.168.0.105:2971] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Fsystem%2Fbundle%2Fmedia%2Fflags%2Fstudio%2FWii%2520U%2520Crash%3Ft%3D1406923978&width=400&height=80 (8 live)
Aug 31, 2014 10:20:55:578 [8736] DEBUG - * minSize => 1
Aug 31, 2014 10:20:55:578 [7072] DEBUG - Final path: C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\img\blank.png
Aug 31, 2014 10:20:55:578 [6760] DEBUG - * url => http://127.0.0.1:32400/system/bundle/media/flags/studio/Wii U Crash?t=1406923978
Aug 31, 2014 10:20:55:578 [6760] DEBUG - * width => 400
Aug 31, 2014 10:20:55:578 [6760] DEBUG - * height => 80
Aug 31, 2014 10:20:55:578 [8736] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:55:579 [6760] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/system/bundle/media/flags/studio/Wii U Crash?t=1406923978] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:55:629 [7072] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle\Contents\Resources\img\blank.png is 926.
Aug 31, 2014 10:20:55:736 [7072] DEBUG - Request: [192.168.0.105:2972] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Fsystem%2Fbundle%2Fmedia%2Fflags%2FcontentRating%2FR%3Ft%3D1406923978&width=140&height=60 (8 live)
Aug 31, 2014 10:20:55:736 [7072] DEBUG - * url => http://127.0.0.1:32400/system/bundle/media/flags/contentRating/R?t=1406923978
Aug 31, 2014 10:20:55:737 [7072] DEBUG - * width => 140
Aug 31, 2014 10:20:55:737 [7072] DEBUG - * height => 60
Aug 31, 2014 10:20:55:737 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\33\33d08430b6976ee42bc98107d7cccce27ae16e5f.jpg is 125.
Aug 31, 2014 10:20:55:737 [7072] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/system/bundle/media/flags/contentRating/R?t=1406923978] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:55:756 [6760] DEBUG - Request: [192.168.0.105:2973] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Fsystem%2Fbundle%2Fmedia%2Fflags%2FvideoResolution%2F720%3Ft%3D1406923978&width=200&height=40 (8 live)
Aug 31, 2014 10:20:55:756 [6760] DEBUG - * url => http://127.0.0.1:32400/system/bundle/media/flags/videoResolution/720?t=1406923978
Aug 31, 2014 10:20:55:757 [6760] DEBUG - * width => 200
Aug 31, 2014 10:20:55:757 [6760] DEBUG - * height => 40
Aug 31, 2014 10:20:55:757 [6760] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/system/bundle/media/flags/videoResolution/720?t=1406923978] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:55:770 [7640] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\f8\f8c88b93a1969aa8e679144da124465748eba961.jpg is 13454.
Aug 31, 2014 10:20:55:789 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\0a\0aa5dcc3e35ef80c556e7048e65d9ca6bcd29488.jpg is 124634.
Aug 31, 2014 10:20:55:948 [7072] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\3f\3f0834a792b1fb89c173f5bbeea23399c3b6765d.jpg is 1495.
Aug 31, 2014 10:20:56:014 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\b1\b113bac8aad4b6e6b3ef04009c0484102e243987.jpg is 1997.
Aug 31, 2014 10:20:56:043 [8544] DEBUG - Request: [192.168.0.105:2974] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Fsystem%2Fbundle%2Fmedia%2Fflags%2FaudioCodec%2Fvorbis%3Ft%3D1406923978&width=200&height=40 (8 live)
Aug 31, 2014 10:20:56:044 [8544] DEBUG - * url => http://127.0.0.1:32400/system/bundle/media/flags/audioCodec/vorbis?t=1406923978
Aug 31, 2014 10:20:56:044 [8544] DEBUG - * width => 200
Aug 31, 2014 10:20:56:044 [8544] DEBUG - * height => 40
Aug 31, 2014 10:20:56:044 [8544] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/system/bundle/media/flags/audioCodec/vorbis?t=1406923978] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:56:100 [8736] DEBUG - Request: [192.168.0.105:2975] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Fsystem%2Fbundle%2Fmedia%2Fflags%2FaudioChannels%2F2%3Ft%3D1406923978&width=200&height=40 (8 live)
Aug 31, 2014 10:20:56:100 [8736] DEBUG - * url => http://127.0.0.1:32400/system/bundle/media/flags/audioChannels/2?t=1406923978
Aug 31, 2014 10:20:56:100 [8736] DEBUG - * width => 200
Aug 31, 2014 10:20:56:100 [8736] DEBUG - * height => 40
Aug 31, 2014 10:20:56:101 [8736] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/system/bundle/media/flags/audioChannels/2?t=1406923978] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:56:137 [8544] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\e6\e672d5388914dc2d0563a8e36d1cdd8727e3a41c.jpg is 2604.
Aug 31, 2014 10:20:56:213 [8736] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\e5\e59dd24c5866d85351426da3cc8da249db20a5e0.jpg is 1370.
Aug 31, 2014 10:20:58:379 [7072] DEBUG - Request: [192.168.0.105:2976] OPTIONS /playQueues?type=video&uri=library%3A%2F%2F1fa4a813-22b6-407c-9e1b-89881da811b5%2Fitem%2F%252Flibrary%252Fmetadata%252F2468&shuffle=0 (8 live)
Aug 31, 2014 10:20:58:379 [7072] DEBUG - * type => video
Aug 31, 2014 10:20:58:379 [7072] DEBUG - * uri => library://1fa4a813-22b6-407c-9e1b-89881da811b5/item/%2Flibrary%2Fmetadata%2F2468
Aug 31, 2014 10:20:58:379 [7072] DEBUG - * shuffle => 0
Aug 31, 2014 10:20:58:393 [8736] DEBUG - Request: [192.168.0.105:2977] POST /playQueues?type=video&uri=library%3A%2F%2F1fa4a813-22b6-407c-9e1b-89881da811b5%2Fitem%2F%252Flibrary%252Fmetadata%252F2468&shuffle=0 (8 live)
Aug 31, 2014 10:20:58:393 [8736] DEBUG - * type => video
Aug 31, 2014 10:20:58:393 [8736] DEBUG - * uri => library://1fa4a813-22b6-407c-9e1b-89881da811b5/item/%2Flibrary%2Fmetadata%2F2468
Aug 31, 2014 10:20:58:393 [8736] DEBUG - * shuffle => 0
Aug 31, 2014 10:20:58:698 [8736] DEBUG - PlayQueue: Start index: 0 End index: 0 Count: 1
Aug 31, 2014 10:20:58:911 [8736] DEBUG - PlayQueue: 1 generated IDs compressed down to a 24 byte blob.
Aug 31, 2014 10:20:59:018 [8736] DEBUG - PlayQueue: Added 1 items in 0.1 sec.
Aug 31, 2014 10:20:59:112 [8736] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:59:896 [7640] DEBUG - Request: [192.168.0.105:2978] OPTIONS /library/metadata/2468?checkFiles=1 (9 live)
Aug 31, 2014 10:20:59:896 [7640] DEBUG - * checkFiles => 1
Aug 31, 2014 10:20:59:897 [6760] DEBUG - Request: [192.168.0.105:2979] GET /photo/:/transcode?url=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468%2Fthumb%2F1409417948&width=200&height=300&minSize=1 (8 live)
Aug 31, 2014 10:20:59:897 [6760] DEBUG - * url => http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948
Aug 31, 2014 10:20:59:897 [6760] DEBUG - * width => 200
Aug 31, 2014 10:20:59:897 [6760] DEBUG - * height => 300
Aug 31, 2014 10:20:59:897 [6760] DEBUG - * minSize => 1
Aug 31, 2014 10:20:59:898 [6760] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/library/metadata/2468/thumb/1409417948] (is local: 1 upscaled: 0)
Aug 31, 2014 10:20:59:912 [7072] DEBUG - Request: [192.168.0.105:2980] GET /library/metadata/2468?checkFiles=1 (8 live)
Aug 31, 2014 10:20:59:912 [7072] DEBUG - * checkFiles => 1
Aug 31, 2014 10:20:59:918 [7072] DEBUG - Last refresh (2014-08-30 18:59:08) appears to be older than directory change time (2014-08-30 22:07:41), need to refresh local media agent.
Aug 31, 2014 10:20:59:918 [7072] DEBUG - Refreshing GUID: 'com.plexapp.agents.imdb://tt0375679?lang=en'
Aug 31, 2014 10:20:59:918 [7072] DEBUG - HTTP requesting to: http://127.0.0.1:32400/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:59:929 [7640] DEBUG - Request: [127.0.0.1:28218] GET /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0 (8 live)
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * mediaType => 1
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * force => 1
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * guid => com.plexapp.agents.imdb://tt0375679?lang=en
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * id => 2468
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * agent => com.plexapp.agents.localmedia
Aug 31, 2014 10:20:59:929 [7640] DEBUG - * async => 0
Aug 31, 2014 10:20:59:930 [7640] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:59:930 [7640] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:20:59:938 [8736] DEBUG - Request: [127.0.0.1:28220] GET /:/plugins (8 live)
Aug 31, 2014 10:20:59:938 [8736] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:59:941 [7640] DEBUG - [com.plexapp.system] HTTP reply status 200, with 99 bytes of content.
Aug 31, 2014 10:20:59:942 [7072] ERROR - Error response for update: 2 (Agent not found).
Aug 31, 2014 10:20:59:943 [7072] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:20:59:951 [6760] DEBUG - Content-Length of C:\Users\USERNAME\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\8f\8f6d70977265af5172d5f77d4276a722acf67121.jpg is 24594.
Aug 31, 2014 10:21:01:328 [8736] DEBUG - Request: [192.168.0.105:2981] OPTIONS /:/timeline?ratingKey=2468&key=%2Flibrary%2Fmetadata%2F2468&state=paused&playQueueItemID=82&time=0&duration=5242 (8 live)
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * ratingKey => 2468
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * key => /library/metadata/2468
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * state => paused
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * playQueueItemID => 82
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * time => 0
Aug 31, 2014 10:21:01:328 [8736] DEBUG - * duration => 5242
Aug 31, 2014 10:21:01:877 [7640] DEBUG - Request: [192.168.0.105:2982] GET /:/timeline?ratingKey=2468&key=%2Flibrary%2Fmetadata%2F2468&state=paused&playQueueItemID=82&time=0&duration=5242 (8 live)
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * ratingKey => 2468
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * key => /library/metadata/2468
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * state => paused
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * playQueueItemID => 82
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * time => 0
Aug 31, 2014 10:21:01:877 [7640] DEBUG - * duration => 5242
Aug 31, 2014 10:21:01:877 [7640] DEBUG - Client [n9r0fg2s18] reporting timeline state paused, progress of 0/5242ms for guid=, ratingKey=2468 url=, key=/library/metadata/2468, containerKey=, metadataId=2468
Aug 31, 2014 10:21:01:877 [7640] DEBUG - [Now] Device is Wii U (Plex Web (Wii U)).
Aug 31, 2014 10:21:01:877 [7640] DEBUG - [Now] Updated play state for /library/metadata/2468.
Aug 31, 2014 10:21:01:878 [8988] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/2468
Aug 31, 2014 10:21:01:884 [8988] DEBUG - Last refresh (2014-08-30 18:59:08) appears to be older than directory change time (2014-08-30 22:07:41), need to refresh local media agent.
Aug 31, 2014 10:21:01:884 [8988] DEBUG - Refreshing GUID: 'com.plexapp.agents.imdb://tt0375679?lang=en'
Aug 31, 2014 10:21:01:884 [8988] DEBUG - HTTP requesting to: http://127.0.0.1:32400/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:01:885 [8736] DEBUG - Request: [127.0.0.1:28221] GET /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0 (8 live)
Aug 31, 2014 10:21:01:885 [8736] DEBUG - * mediaType => 1
Aug 31, 2014 10:21:01:886 [8736] DEBUG - * force => 1
Aug 31, 2014 10:21:01:886 [8736] DEBUG - * guid => com.plexapp.agents.imdb://tt0375679?lang=en
Aug 31, 2014 10:21:01:886 [8736] DEBUG - * id => 2468
Aug 31, 2014 10:21:01:886 [8736] DEBUG - * agent => com.plexapp.agents.localmedia
Aug 31, 2014 10:21:01:886 [8736] DEBUG - * async => 0
Aug 31, 2014 10:21:01:886 [8736] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:01:886 [8736] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:01:894 [6760] DEBUG - Request: [127.0.0.1:28223] GET /:/plugins (8 live)
Aug 31, 2014 10:21:01:894 [6760] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:21:01:898 [8736] DEBUG - [com.plexapp.system] HTTP reply status 200, with 99 bytes of content.
Aug 31, 2014 10:21:01:899 [8988] ERROR - Error response for update: 2 (Agent not found).
Aug 31, 2014 10:21:01:900 [8988] DEBUG - It took 0.001000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:21:01:901 [8988] DEBUG - Caching document http://127.0.0.1:32400/library/metadata/2468
Aug 31, 2014 10:21:01:902 [8988] DEBUG - [Now] Added metadata for /library/metadata/2468.
Aug 31, 2014 10:21:02:095 [7640] DEBUG - Request: [192.168.0.105:2983] OPTIONS /status/sessions (8 live)
Aug 31, 2014 10:21:02:112 [7640] DEBUG - Request: [192.168.0.105:2984] GET /status/sessions (8 live)
Aug 31, 2014 10:21:02:891 [6760] DEBUG - Request: [192.168.0.105:2985] GET /video/:/transcode/universal/start.m3u8?path=http%3A%2F%2F127.0.0.1%3A32400%2Flibrary%2Fmetadata%2F2468&mediaIndex=0&partIndex=0&protocol=hls&offset=0&fastSeek=1&directPlay=0&directStream=1&videoQuality=60&videoResolution=1920x1080&maxVideoBitrate=8000&subtitleSize=100&audioBoost=100&session=8s7klwp55v4&X-Plex-Client-Profile-Extra=add-transcode-target-audio-codec(type%3DvideoProfile%26context%3Dstreaming%26protocol%3Dhls%26audioCodec%3Daac)&X-Plex-Client-Identifier=n9r0fg2s18&X-Plex-Product=Plex+Web&X-Plex-Device=Unknown+Platform&X-Plex-Platform=Wii+U&X-Plex-Platform-Version=0&X-Plex-Version=2.2.4&X-Plex-Device-Name=Plex+Web+(Wii+U) (8 live)
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * path => http://127.0.0.1:32400/library/metadata/2468
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * mediaIndex => 0
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * partIndex => 0
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * protocol => hls
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * offset => 0
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * fastSeek => 1
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * directPlay => 0
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * directStream => 1
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * videoQuality => 60
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * videoResolution => 1920x1080
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * maxVideoBitrate => 8000
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * subtitleSize => 100
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * audioBoost => 100
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * session => 8s7klwp55v4
Aug 31, 2014 10:21:02:891 [6760] DEBUG - * X-Plex-Client-Profile-Extra => add-transcode-target-audio-codec(type=videoProfile&context=streaming&protocol=hls&audioCodec=aac)
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Client-Identifier => n9r0fg2s18
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Product => Plex Web
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Device => Unknown Platform
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Platform => Wii U
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Platform-Version => 0
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Version => 2.2.4
Aug 31, 2014 10:21:02:892 [6760] DEBUG - * X-Plex-Device-Name => Plex Web (Wii U)
Aug 31, 2014 10:21:02:893 [6760] DEBUG - Using augmented profile Wii U
Aug 31, 2014 10:21:02:894 [6760] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/2468
Aug 31, 2014 10:21:02:894 [6760] DEBUG - HTTP requesting to: http://127.0.0.1:32400/library/metadata/2468
Aug 31, 2014 10:21:02:895 [8736] DEBUG - Request: [127.0.0.1:28232] GET /library/metadata/2468 (8 live)
Aug 31, 2014 10:21:02:901 [8736] DEBUG - Last refresh (2014-08-30 18:59:08) appears to be older than directory change time (2014-08-30 22:07:41), need to refresh local media agent.
Aug 31, 2014 10:21:02:901 [8736] DEBUG - Refreshing GUID: 'com.plexapp.agents.imdb://tt0375679?lang=en'
Aug 31, 2014 10:21:02:901 [8736] DEBUG - HTTP requesting to: http://127.0.0.1:32400/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:02:903 [7072] DEBUG - Request: [127.0.0.1:28233] GET /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0 (8 live)
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * mediaType => 1
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * force => 1
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * guid => com.plexapp.agents.imdb://tt0375679?lang=en
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * id => 2468
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * agent => com.plexapp.agents.localmedia
Aug 31, 2014 10:21:02:903 [7072] DEBUG - * async => 0
Aug 31, 2014 10:21:02:903 [7072] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=1&force=1&guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0375679%3Flang%3Den&id=2468&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:02:903 [7072] DEBUG - HTTP requesting to: http://127.0.0.1:28057/system/agent...8&agent=com.plexapp.agents.localmedia&async=0
Aug 31, 2014 10:21:02:912 [8544] DEBUG - Request: [127.0.0.1:28235] GET /:/plugins (8 live)
Aug 31, 2014 10:21:02:912 [8544] DEBUG - It took 0.000000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:21:02:915 [7072] DEBUG - [com.plexapp.system] HTTP reply status 200, with 99 bytes of content.
Aug 31, 2014 10:21:02:916 [8736] ERROR - Error response for update: 2 (Agent not found).
Aug 31, 2014 10:21:02:918 [8736] DEBUG - It took 0.002000 sec to serialize a list with 1 elements.
Aug 31, 2014 10:21:02:919 [6760] DEBUG - MDE: analyzing video part 2468: mkv/h264/vorbis/
Aug 31, 2014 10:21:02:919 [6760] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/aac/
Aug 31, 2014 10:21:02:919 [6760] DEBUG - MDE: remuxing h264 video stream
Aug 31, 2014 10:21:02:919 [6760] DEBUG - MDE: selected media 0
Aug 31, 2014 10:21:02:920 [6760] DEBUG - [Universal] Using local file path instead of URL: C:\xampp\WiiUCrash\crash.mkv
Aug 31, 2014 10:21:02:920 [6760] DEBUG - [Universal] Remuxing to hls/mpegts/h264/aac
Aug 31, 2014 10:21:02:920 [6760] DEBUG - Found session GUID of 8s7klwp55v4 in session start.
Aug 31, 2014 10:21:02:920 [6760] DEBUG - Using session GUID 8s7klwp55v4 for new transcode session.
Aug 31, 2014 10:21:02:921 [6760] DEBUG - Cleaning directory for session 8s7klwp55v4 (C:\Users\CHRISX~1\AppData\Local\Temp\plex-transcode-8s7klwp55v4-d491e066-7946-4248-b071-413a27beec59)
Aug 31, 2014 10:21:03:075 [7640] DEBUG - Request: [192.168.0.105:2986] GET /video/:/transcode/universal/session/8s7klwp55v4/base/index.m3u8 (8 live)
Aug 31, 2014 10:21:03:075 [7640] DEBUG - MDE: analyzing video part 2468: mkv/h264/vorbis/
Aug 31, 2014 10:21:03:075 [7640] DEBUG - MDE: selected video transcode profile: hls - mpegts/h264/aac/
Aug 31, 2014 10:21:03:075 [7640] DEBUG - MDE: remuxing h264 video stream
Aug 31, 2014 10:21:03:076 [7640] DEBUG - MDE: selected media 0
Aug 31, 2014 10:21:03:076 [7640] DEBUG - [Universal] Using local file path instead of URL: C:\xampp\WiiUCrash\crash.mkv
Aug 31, 2014 10:21:03:076 [7640] DEBUG - [Universal] Remuxing to hls/mpegts/h264/aac
Aug 31, 2014 10:21:03:076 [7640] DEBUG - Starting a transcode session 8s7klwp55v4 at offset -1.0 (stopped=1)
Aug 31, 2014 10:21:03:077 [7640] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\PlexNewTranscoder.exe -i "C:\xampp\WiiUCrash\crash.mkv" -threads "0" "-y" -segment_format "mpegts" -f "segment" -loglevel "quiet" -loglevel_plex "error" -map_metadata "-1" -progressurl "http://127.0.0.1:32400/video/:/transcode/session/8s7klwp55v4/progress" -vcodec "copy" -flags "-global_header" -segment_time "10" -segment_start_number "0" -bsf "h264_mp4toannexb,h264_plex" -map "0:0" "-sn" -acodec "aac" -strict "-2" -cutoff "15000" -ac "2" -map "0:1" -ab "128k" "media-%05d.ts"
Aug 31, 2014 10:21:03:809 [7072] DEBUG - Request: [192.168.0.105:2987] OPTIONS /:/timeline?ratingKey=2468&key=%2Flibrary%2Fmetadata%2F2468&state=buffering&playQueueItemID=82&time=0&duration=5242 (8 live)
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * ratingKey => 2468
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * key => /library/metadata/2468
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * state => buffering
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * playQueueItemID => 82
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * time => 0
Aug 31, 2014 10:21:03:809 [7072] DEBUG - * duration => 5242
Aug 31, 2014 10:21:04:476 [7072] DEBUG - Request: [192.168.0.105:2988] GET /:/timeline?ratingKey=2468&key=%2Flibrary%2Fmetadata%2F2468&state=buffering&playQueueItemID=82&time=0&duration=5242 (8 live)
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * ratingKey => 2468
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * key => /library/metadata/2468
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * state => buffering
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * playQueueItemID => 82
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * time => 0
Aug 31, 2014 10:21:04:476 [7072] DEBUG - * duration => 5242
Aug 31, 2014 10:21:04:477 [7072] DEBUG - Client [n9r0fg2s18] reporting timeline state buffering, progress of 0/5242ms for guid=, ratingKey=2468 url=, key=/library/metadata/2468, containerKey=, metadataId=2468
Aug 31, 2014 10:21:04:477 [7072] DEBUG - [Now] Device is Wii U (Plex Web (Wii U)).
Aug 31, 2014 10:21:04:477 [7072] DEBUG - [Now] Updated play state for /library/metadata/2468.
Aug 31, 2014 10:21:04:579 [6760] DEBUG - Request: [192.168.0.105:2989] GET /status/sessions (8 live)
Aug 31, 2014 10:21:04:830 [8544] INFO - [Transcoder] Input #0, matroska,webm, from 'C:\xampp\WiiUCrash\crash.mkv':
Aug 31, 2014 10:21:04:832 [8736] INFO - [Transcoder] Stream #0:0(eng): Video: h264 (Main), yuv420p, 1280x720, SAR 1:1 DAR 16:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
Aug 31, 2014 10:21:04:833 [7072] INFO - [Transcoder] Stream #0:1: Audio: vorbis, 48000 Hz, stereo, fltp (default)
Aug 31, 2014 10:21:04:835 [6760] DEBUG - [Transcoder] Average FPS ~ 24 fps, Frame rate ~ 24 fps.
Aug 31, 2014 10:21:04:858 [7640] DEBUG - [FFMPEG] Duration: 0
Aug 31, 2014 10:21:04:858 [7640] DEBUG - Read line, and done: 1
Aug 31, 2014 10:21:04:858 [7640] DEBUG - Started session successfully: 8s7klwp55v4
Aug 31, 2014 10:21:04:858 [7640] DEBUG - HLS: Building an M3U8 for 6 total seconds with 10 seconds/segment, target duration of 10.
Aug 31, 2014 10:21:04:876 [8544] INFO - [Transcoder] Output #0, segment, to 'media-%05d.ts':
Aug 31, 2014 10:21:04:878 [8544] INFO - [Transcoder] Stream #0:0: Video: h264, yuv420p, 1280x720 [SAR 1:1 DAR 16:9], q=2-31, 23.98 fps, 90k tbn, 23.98 tbc (default)
Aug 31, 2014 10:21:04:879 [8736] INFO - [Transcoder] Stream #0:1: Audio: aac, 48000 Hz, stereo, fltp, 128 kb/s (default)
Aug 31, 2014 10:21:04:881 [7072] DEBUG - Request: [127.0.0.1:28267] PUT /video/:/transcode/session/8s7klwp55v4/progress?width=1280&height=720 (8 live)
Aug 31, 2014 10:21:04:881 [7072] DEBUG - * width => 1280
Aug 31, 2014 10:21:04:881 [7072] DEBUG - * height => 720
Aug 31, 2014 10:21:04:881 [7072] DEBUG - We want 6 segments ahead, last returned was -1 and max is -1.
Aug 31, 2014 10:21:04:881 [7072] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:21:04:976 [8736] DEBUG - Request: [192.168.0.105:2990] GET /video/:/transcode/universal/session/8s7klwp55v4/base/00000.ts (8 live)
Aug 31, 2014 10:21:04:976 [8736] DEBUG - Asked for segment 0 from session.
Aug 31, 2014 10:21:04:998 [7072] DEBUG - Request: [127.0.0.1:28268] PUT /video/:/transcode/session/8s7klwp55v4/progress?progress=nan&size=-22&speed=inf&remaining=0 (8 live)
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * progress => nan
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * size => -22
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * speed => inf
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * remaining => 0
Aug 31, 2014 10:21:04:999 [7072] DEBUG - We want 6 segments ahead, last returned was -1 and max is 0.
Aug 31, 2014 10:21:04:999 [7072] DEBUG - It took 0.000000 sec to serialize a list with 0 elements.
Aug 31, 2014 10:21:05:096 [8736] DEBUG - Returning segment 0 from session: C:\Users\CHRISX~1\AppData\Local\Temp\plex-transcode-8s7klwp55v4-d491e066-7946-4248-b071-413a27beec59\media-00000.ts
Aug 31, 2014 10:21:05:096 [8736] DEBUG - Content-Length of C:\Users\CHRISX~1\AppData\Local\Temp\plex-transcode-8s7klwp55v4-d491e066-7946-4248-b071-413a27beec59\media-00000.ts is 73884.
Aug 31, 2014 10:21:06:942 [7996] DEBUG - Network change.
Aug 31, 2014 10:21:06:942 [7996] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:21:06:957 [7996] DEBUG - Network change notification but nothing changed.
Aug 31, 2014 10:21:06:957 [7996] DEBUG - Network change.
Aug 31, 2014 10:21:06:957 [7996] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:21:06:972 [7996] DEBUG - Network change notification but nothing changed.
Aug 31, 2014 10:21:09:080 [5032] ERROR - handle_stream_read error 10054 Eine vorhandene Verbindung wurde vom Remotehost geschlossen
Aug 31, 2014 10:21:09:081 [5032] DEBUG - Removing notification stream because of error.
Aug 31, 2014 10:21:18:075 [3496] DEBUG - [com.plexapp.system] HTTP reply status 200, with 5773 bytes of content.
Aug 31, 2014 10:21:18:078 [3496] DEBUG - The system knows about 11 agents.
Aug 31, 2014 10:21:18:079 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Framework.bundle.
Aug 31, 2014 10:21:18:079 [3496] DEBUG - Waiting for all 18 plug-ins to finish starting.
Aug 31, 2014 10:21:18:079 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\HTbackdrops.bundle.
Aug 31, 2014 10:21:18:079 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\IMDB.bundle.
Aug 31, 2014 10:21:18:080 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\LastFM.bundle.
Aug 31, 2014 10:21:18:081 [6088] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
Aug 31, 2014 10:21:18:081 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\LocalMedia.bundle.
Aug 31, 2014 10:21:18:081 [6780] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
Aug 31, 2014 10:21:18:082 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Media-Flags.bundle.
Aug 31, 2014 10:21:18:082 [6956] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
Aug 31, 2014 10:21:18:082 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\MoviePosterDB.bundle.
Aug 31, 2014 10:21:18:082 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\OpenSubtitles.bundle.
Aug 31, 2014 10:21:18:083 [6088] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
Aug 31, 2014 10:21:18:083 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\PersonalMedia.bundle.
Aug 31, 2014 10:21:18:083 [6956] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
Aug 31, 2014 10:21:18:083 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\PlexThemeMusic.bundle.
Aug 31, 2014 10:21:18:084 [6780] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.opensubtitles] yet.
Aug 31, 2014 10:21:18:084 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Scanners.bundle.
Aug 31, 2014 10:21:18:084 [6088] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
Aug 31, 2014 10:21:18:084 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Services.bundle.
Aug 31, 2014 10:21:18:085 [6956] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
Aug 31, 2014 10:21:18:085 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\SiteConfigurations.bundle.
Aug 31, 2014 10:21:18:085 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\The-Movie-Database.bundle.
Aug 31, 2014 10:21:18:085 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\TheTVDB.bundle.
Aug 31, 2014 10:21:18:085 [6780] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebClient.bundle.
Aug 31, 2014 10:21:18:086 [6956] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
Aug 31, 2014 10:21:18:086 [6956] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\WebManager.bundle.
Aug 31, 2014 10:21:18:086 [6088] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
Aug 31, 2014 10:21:18:087 [6088] DEBUG - Starting plug-in C:\Users\USERNAME\AppData\Local\Plex Media Server\Plug-ins\Wikipedia.bundle.
Aug 31, 2014 10:21:18:088 [6088] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.wikipedia] yet.
Aug 31, 2014 10:21:18:127 [5976] DEBUG - [com.plexapp.system] HTTP reply status 200, with 86224 bytes of content.
Aug 31, 2014 10:21:18:179 [3496] DEBUG - Done waiting for all plug-ins to start.
Aug 31, 2014 10:21:19:946 [7996] DEBUG - Network change.
Aug 31, 2014 10:21:19:946 [7996] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:21:19:963 [7996] DEBUG - Network change notification but nothing changed.
Aug 31, 2014 10:21:19:963 [7996] DEBUG - Network change.
Aug 31, 2014 10:21:19:963 [7996] DEBUG - NetworkInterface: Notified of network changed (force=0)
Aug 31, 2014 10:21:19:978 [7996] DEBUG - Network change notification but nothing changed.
Aug 31, 2014 10:21:54:855 [0120] DEBUG - Ordered to stop server.
Aug 31, 2014 10:21:54:855 [8500] DEBUG - Stopping server...
Aug 31, 2014 10:21:54:857 [3016] DEBUG - Sync: cancelCurrentTranscode
Aug 31, 2014 10:21:54:858 [8500] DEBUG - Server stopped.
Aug 31, 2014 10:21:54:858 [8500] DEBUG - NetworkService: Stopping advertisement.
Aug 31, 2014 10:21:54:858 [8500] DEBUG - Killing job.
Aug 31, 2014 10:21:54:859 [8500] DEBUG - Job was already killed, not killing again.
Aug 31, 2014 10:21:54:859 [8500] DEBUG - Stopping transcode session 8s7klwp55v4
Aug 31, 2014 10:21:54:859 [8500] DEBUG - Cleaning directory for session 8s7klwp55v4 (C:\Users\CHRISX~1\AppData\Local\Temp\plex-transcode-8s7klwp55v4-d491e066-7946-4248-b071-413a27beec59)
Aug 31, 2014 10:21:54:860 [8500] DEBUG - Killing plug-ins.
Aug 31, 2014 10:21:54:860 [8500] DEBUG - [com.plexapp.system] Killing.
Aug 31, 2014 10:21:54:860 [8500] DEBUG - Waiting for DLNA server to exit.
Aug 31, 2014 10:21:55:137 [8308] DEBUG - DLNA Server exited.
Aug 31, 2014 10:21:55:138 [8500] DEBUG - WebKit: Stream closed.
Aug 31, 2014 10:21:55:138 [8500] DEBUG - WK_BrowseToURL about:blank
 
Hey Guys,

We got some great news!


ich habe die Ursache, warum die .mkv einen Crash verursacht. Es liegt am Codec von Audio "Vorbis". Ich habe mal eine Datei, die bei mir funktioniert von .flv in .mov umgewandelt. Die normale .mov Datei funktioniert, aber dann habe ich erneut die Datei aber diesmal mit Audio: Codec (Vorbis stereo) umgewandelt und die Datei verursacht bei mir auch einen White Screen im Wii U browser.
Fazit:
Audio (Codec: Vorbis) müsste die ursache sein, egal was für eine Videodatei.


I posted my first post (in german) on Wii-Homebrew.com.
Here`s the thread

Taurus, a user who is active there, figured out that the problem comes from the Audio Codec "Vorbis".
He tried to convert the mkv to flv and mov. The mov-File worked till he converted the Audio-Stream to Vorbis.

It seems that PLEX is not able to handle vorbis on Wii U.
 
yes, but PLEX plays only video files, or it can also stream audio files? (radio, mp3, ogg, mpc, etc?)
did you test extracting the audio stream and playing it as direct audio-stream from plex?
 
yes, but PLEX plays only video files, or it can also stream audio files? (radio, mp3, ogg, mpc, etc?)
did you test extracting only the audio and loading it as direct audio-stream from plex?

I'll test it now.


EDIT:
Converted the video with DVDVideosoft Audio Converter to ogg with original audio-stream.
Can add the video with Plex to the library AND can play it on PC:
Wii U won't play the audio-file. No crash.
 
Aug 31, 2014 10:21:09:080 [5032] ERROR - handle_stream_read error 10054 Eine vorhandene Verbindung wurde vom Remotehost geschlossen


That means "An existing connection was forcibly closed by the remote host". Just FYI.

Also, the lines

Aug 31, 2014 10:21:04:998 [7072] DEBUG - * progress => nan
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * size => -22
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * speed => inf
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * remaining => 0

after the transcoding, but before the above error, mean that the file wasn't properly transcoded (a file should not be a negative number of bytes with 0 remaining bytes to convert. This is most likely what causes the crash.)
 
  • Like
Reactions: MOHRCORE
That means "An existing connection was forcibly closed by the remote host". Just FYI.

Also, the lines

Aug 31, 2014 10:21:04:998 [7072] DEBUG - * progress => nan
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * size => -22
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * speed => inf
Aug 31, 2014 10:21:04:998 [7072] DEBUG - * remaining => 0

after the transcoding, but before the above error, mean that the file wasn't properly transcoded (a file should not be a negative number of bytes with 0 remaining bytes to convert. This is most likely what causes the crash.)
So... Goood? ... Bad?
 
Status
Not open for further replies.

Site & Scene News

Popular threads in this forum