Jump to content


Photo

Sony BDP-S390 doesnt work after update to .28


  • Please log in to reply
23 replies to this topic

#1 eklynner

eklynner

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 12 June 2013 - 04:14 PM

Upgraded Plex to the new .28 version yesterday and now my Player doesn't play any of my MP4's. It says error transcoding corrupted file. I downgraded back to .22 and everything works again is anyone else seeing this issue?



#2 Segran

Segran

    Dedicated Member

  • Members
  • PipPipPip
  • 154 posts

Posted 13 June 2013 - 10:02 PM

Same with BDP-S470 and 0.9.8.36.....



#3 fooberichu

fooberichu

    Newbie

  • Members
  • Pip
  • 1 posts

Posted 20 June 2013 - 01:58 AM

The same thing happened for me with 0.9.728.33 and a Sony BDP-S590.  I even tried installing a fresh copy of .33 on a new machine with the same result.  Downgraded to 0.9.722 and everything is dandy again.



#4 stubblechunks

stubblechunks

    Newbie

  • Members
  • Pip
  • 5 posts

Posted 23 June 2013 - 03:32 PM

I just discovered Plex yesterday, so I can't say whether my BDP-S590 would have worked with an earlier version.  Is there a page that has historical versions of the Plex server so that I can test that hypothesis?



#5 Jackdanl

Jackdanl

    Newbie

  • Members
  • Pip
  • 1 posts

Posted 27 June 2013 - 04:02 AM

I have a Sony BDP-S590. I have also noticed that when I update to .28 it will no longer work, giving the error file type not supported. After uninstalling and downgrading to a previous version 0.9.7.22, everything is fine again.

 

Any help would be appreciated, if you need logs etc, just let me know and I will upgrade and get them for you.

 

Thank you,

JackD 



#6 rickardsfive

rickardsfive

    Newbie

  • Members
  • Pip
  • 1 posts

Posted 27 June 2013 - 08:55 PM

I just discovered Plex yesterday, so I can't say whether my BDP-S590 would have worked with an earlier version.  Is there a page that has historical versions of the Plex server so that I can test that hypothesis?

Took some finding..
http://wiki.plexapp....s#Windows_-_PMS



#7 orb360

orb360

    Newbie

  • Members
  • Pip
  • 5 posts

Posted 28 June 2013 - 02:46 AM

Sony BDP-BX59 reporting in... All files complain about being corrupt on 0.28, older 0.22 still works fine.



#8 iphoneuser

iphoneuser

    Member

  • Members
  • PipPip
  • 67 posts

Posted 28 June 2013 - 05:46 PM

The Devs must habe changed Main Parts of the transcoding. Problems all around not only DLNA. See here:
http://forums.plexap...09726/?p=414831

#9 tonyd115

tonyd115

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 28 June 2013 - 08:39 PM

Same issue on Sony BDP-S790 and a KDL-46HX820 TV.  Both stop processing video files early to mid run after installing latest update 0.9.7.28 to Media Server.

 

tonyd115



#10 mfeingol

mfeingol

    Plex Dev Team

  • Plex Employee
  • PipPipPipPipPipPip
  • 3950 posts
  • Location: Redmond

Posted 10 July 2013 - 02:15 AM

We're using an updated transcoder, for what that's worth.

So I have a BDP-S5100 and it seems to work great with 0.9.8.x. How can I reproduce the problems?

#11 eklynner

eklynner

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 10 July 2013 - 04:39 PM

We're using an updated transcoder, for what that's worth.

So I have a BDP-S5100 and it seems to work great with 0.9.8.x. How can I reproduce the problems?

 

I would suggest not using an updated transcoder? All i did was just install the base package on my windows 7 machine and it broke, uninstalled re-installed .22 and everything came back to life.



#12 eklynner

eklynner

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 10 July 2013 - 04:40 PM

We're using an updated transcoder, for what that's worth.

So I have a BDP-S5100 and it seems to work great with 0.9.8.x. How can I reproduce the problems?

 

If you want get me a copy of 9.8 and i will glady test it for you and see if the issue fixed.



#13 mfeingol

mfeingol

    Plex Dev Team

  • Plex Employee
  • PipPipPipPipPipPip
  • 3950 posts
  • Location: Redmond

Posted 10 July 2013 - 06:43 PM

Simplest path is to acquire a PlexPass. :)

0.9.8.2 will be out soon, so we should probably just wait for that.

#14 eklynner

eklynner

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 10 July 2013 - 06:47 PM

If it's going to be out soon that is fine with me, i can run on .22 for awhile yet

#15 wjclerk

wjclerk

    Newbie

  • Members
  • Pip
  • 2 posts

Posted 27 July 2013 - 06:18 PM

I was having this same problem. I tried uninstalling .28 and installed .22 instead, restarted PMS, rebooted my computer and Sony Blu-ray player, and still it reports "Unable to connect to server. Please try again later." Running PMC on my W7 PC's on the same network connects and plays just fine. It would appear to me to be a configuration issue with PMS. Here is the dnla log from the server running on a Windows 7 64-bit Professional 3.2MHZ 16GB Ram system:

 

Jul 27, 2013 11:55:49:572 [4384] DEBUG - Starting Plex DLNA Server 0.9.7.22-4b5280f...
Jul 27, 2013 11:55:49:572 [4384] ERROR - Parsing DlnaClientPreferences: invalid parameter 'LocalResolution'
Jul 27, 2013 11:55:49:572 [4384] DEBUG - Unique device name = bc745cf2-4f8e-4197-c757-6d38d4f77cdc
Jul 27, 2013 11:55:49:572 [4384] DEBUG - DLNA server port: 32469
Jul 27, 2013 11:55:49:572 [4384] DEBUG - PMS: http://127.0.0.1:32400/
Jul 27, 2013 11:55:49:572 [4384] DEBUG - MyPlex: https://my.plexapp.com/
Jul 27, 2013 11:55:49:589 [4384] DEBUG - Reading system DLNA profiles
Jul 27, 2013 11:55:49:592 [4384] DEBUG - No client DLNA profiles found, using only system profiles
Jul 27, 2013 11:55:49:599 [4384] DEBUG - DLNA device discovery enabled every 60 seconds
Jul 27, 2013 11:55:49:611 [4384] DEBUG - Initialization complete
Jul 27, 2013 11:55:51:465 [7248] DEBUG - OnGetProtocolInfo from 192.168.0.3
Jul 27, 2013 11:55:51:465 [7248] DEBUG - Mapped client to profile Blu-ray Disc Player using header av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 27, 2013 12:05:43:732 [8820] DEBUG - GET for http://127.0.0.1:324...na-icon-260.png
Jul 27, 2013 12:05:43:732 [8820] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-260.png
Jul 27, 2013 12:10:41:213 [5792] DEBUG - OnGetProtocolInfo from 192.168.0.3
Jul 27, 2013 12:10:41:213 [5792] DEBUG - Mapped client to profile Blu-ray Disc Player using header av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 27, 2013 12:10:42:745 [1832] DEBUG - GET for http://127.0.0.1:324...na-icon-260.png
Jul 27, 2013 12:10:42:745 [1832] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-260.png
Jul 27, 2013 12:13:45:194 [7704] DEBUG - GET for http://192.168.0.9:3...na-icon-260.png
Jul 27, 2013 12:13:45:194 [7704] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-260.png

 

I noticed that it is attempting to go to 127.0.0.1 to access PMS, but the static IP that I have for it is 192.168.0.9. Could it (the Sony BDP-S390) be trying to go to the localhost to get the stream instead of the static IP? I do have port forwarding set on my wireless DSL router. Any ideas? (or do I need to provide more information from somewhere to diagnose this?)



#16 mfeingol

mfeingol

    Plex Dev Team

  • Plex Employee
  • PipPipPipPipPipPip
  • 3950 posts
  • Location: Redmond

Posted 29 July 2013 - 07:32 PM

I recommend baselining to 0.9.8.3 for DLNA issues like this. My S5100 is working well with that release, and photos should work in 0.9.8.4.

I don't think the 127.0.0.1 issue is relevant.

#17 wjclerk

wjclerk

    Newbie

  • Members
  • Pip
  • 2 posts

Posted 29 July 2013 - 11:59 PM

Thanks for the reply mfeingol. I got my plexpass and downloaded 0.9.8.3 and installed it. I get the list of movies on my Sony Blu-ray player now (like it is connecting to the server and getting data), but when I attempt to play any movie, I get a "file is corrupt or unsupported" error message. I have looked in my server.log file and cannot see where the movie is being called or whether it is directplay or transcode. I have restarted both the Blu-ray player and PMS. THe same movies play on PMC on my PC's on my network (W7 64bit Pro). Here is the log:

 

Jul 29, 2013 17:54:17:709 [8432] DEBUG - Starting Plex DLNA Server 0.9.8.3.96-eee3b6a...
Jul 29, 2013 17:54:17:709 [8432] DEBUG - Unique device name = bc745cf2-4f8e-4197-c757-6d38d4f77cdc
Jul 29, 2013 17:54:17:709 [8432] DEBUG - DLNA server port: 32469
Jul 29, 2013 17:54:17:709 [8432] DEBUG - PMS: http://127.0.0.1:32400/
Jul 29, 2013 17:54:17:709 [8432] DEBUG - MyPlex: https://my.plexapp.com/
Jul 29, 2013 17:54:17:759 [8432] DEBUG - Reading system DLNA client profiles
Jul 29, 2013 17:54:17:779 [8432] DEBUG - Read 13 DLNA client profiles
Jul 29, 2013 17:54:17:779 [8432] DEBUG - DLNA device discovery enabled every 60 seconds
Jul 29, 2013 17:54:17:779 [8432] DEBUG - Initialization complete
Jul 29, 2013 17:54:18:009 [3832] DEBUG - GET for http://192.168.0.9:3...na-icon-260.png
Jul 29, 2013 17:54:18:009 [3832] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-260.png
Jul 29, 2013 17:56:13:978 [0856] DEBUG - OnGetProtocolInfo from 192.168.0.3
Jul 29, 2013 17:56:13:978 [0856] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:14:098 [0928] DEBUG - GET for http://192.168.0.9:3...na-icon-120.jpg
Jul 29, 2013 17:56:14:098 [0928] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-120.jpg
Jul 29, 2013 17:56:14:328 [4028] DEBUG - GET for http://192.168.0.9:3...na-icon-120.jpg
Jul 29, 2013 17:56:14:328 [4028] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-120.jpg
Jul 29, 2013 17:56:20:399 [5816] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '0' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 0 + 10
Jul 29, 2013 17:56:20:399 [5816] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:20:399 [5816] DEBUG - Mapped object 0 to  part 0 on server
Jul 29, 2013 17:56:20:399 [5816] DEBUG - OnBrowseDirectChildren returning success with 3 objects of 3 total
Jul 29, 2013 17:56:22:229 [8920] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '94467912-bd40-4d2f-ad25-7b8423f7b05a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 0 + 10
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Mapped object 94467912-bd40-4d2f-ad25-7b8423f7b05a to  part 0 on server
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Downloading document http://127.0.0.1:324...ibrary/sections
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Loading CAs from 'C:\Program Files (x86)\Plex\Plex Media Server\Resources\cacert.pem'
Jul 29, 2013 17:56:22:229 [8920] DEBUG - HTTP requesting to: http://127.0.0.1:324...ibrary/sections
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Caching document http://127.0.0.1:324...ibrary/sections
Jul 29, 2013 17:56:22:229 [8920] DEBUG - Downloading document http://127.0.0.1:32400/
Jul 29, 2013 17:56:22:229 [8920] DEBUG - HTTP requesting to: http://127.0.0.1:32400/
Jul 29, 2013 17:56:22:239 [8920] DEBUG - Caching document http://127.0.0.1:32400/
Jul 29, 2013 17:56:22:239 [8920] DEBUG - OnBrowseDirectChildren returning success with 8 objects of 8 total
Jul 29, 2013 17:56:23:879 [3936] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for 'c61d7a8237e9cd994f85' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 0 + 10
Jul 29, 2013 17:56:23:879 [3936] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:23:879 [3936] DEBUG - Mapped object c61d7a8237e9cd994f85 to /library/sections/1 part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:23:879 [3936] DEBUG - Downloading document http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:23:879 [3936] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:23:879 [3936] DEBUG - Caching document http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:23:889 [3936] DEBUG - [PERF] Slowest TransactionScope in 10.000000 ms.
Jul 29, 2013 17:56:23:899 [3936] DEBUG - [PERF] Slowest insertObjectID in 10.000000 ms.
Jul 29, 2013 17:56:23:899 [3936] DEBUG - DlnaDidlGenerator::generateForContainer - ignoring special directory inside container /library/sections/1 (21)
Jul 29, 2013 17:56:23:899 [3936] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 18 total
Jul 29, 2013 17:56:24:139 [4164] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for 'c61d7a8237e9cd994f85' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 10 + 10
Jul 29, 2013 17:56:24:139 [4164] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:24:139 [4164] DEBUG - Mapped object c61d7a8237e9cd994f85 to /library/sections/1 part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:24:139 [4164] DEBUG - Downloading document http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:24:139 [4164] DEBUG - Cache hit for document http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:24:139 [4164] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/sections/1
Jul 29, 2013 17:56:24:159 [4164] DEBUG - DlnaDidlGenerator::generateForContainer - ignoring special directory inside container /library/sections/1 (21)
Jul 29, 2013 17:56:24:159 [4164] DEBUG - OnBrowseDirectChildren returning success with 8 objects of 18 total
Jul 29, 2013 17:56:25:869 [8884] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 0 + 10
Jul 29, 2013 17:56:25:869 [8884] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:25:869 [8884] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:25:869 [8884] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:25:869 [8884] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:25:889 [8884] DEBUG - Caching document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:25:899 [8884] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:25:899 [8884] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:26:259 [8884] DEBUG - Caching document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:26:289 [8884] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:26:349 [8884] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:26:369 [8884] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:26:649 [7444] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 10 + 10
Jul 29, 2013 17:56:26:649 [7444] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:26:649 [7444] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:26:649 [7444] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:26:649 [7444] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:26:649 [7444] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:26:679 [7444] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:26:679 [7444] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:26:679 [7444] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:27:059 [7444] DEBUG - [PERF] Slowest insertShortKey in 10.000000 ms.
Jul 29, 2013 17:56:27:069 [7444] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:27:119 [7444] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:27:139 [7444] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:27:419 [2352] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 20 + 10
Jul 29, 2013 17:56:27:419 [2352] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:27:419 [2352] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:27:419 [2352] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:27:419 [2352] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:27:419 [2352] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:27:439 [2352] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:27:439 [2352] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:27:439 [2352] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:27:829 [2352] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:27:879 [2352] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:27:899 [2352] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:28:229 [5052] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 30 + 10
Jul 29, 2013 17:56:28:229 [5052] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:28:229 [5052] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:28:229 [5052] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:28:229 [5052] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:28:229 [5052] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:28:249 [5052] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:28:249 [5052] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:28:249 [5052] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:28:639 [5052] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:28:699 [5052] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:28:719 [5052] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:29:089 [5672] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 40 + 10
Jul 29, 2013 17:56:29:089 [5672] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:29:089 [5672] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:29:089 [5672] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:29:089 [5672] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:29:089 [5672] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:29:119 [5672] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:29:119 [5672] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:29:119 [5672] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:29:509 [5672] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:29:559 [5672] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:29:579 [5672] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:30:019 [7920] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 50 + 10
Jul 29, 2013 17:56:30:019 [7920] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:30:019 [7920] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:30:019 [7920] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:019 [7920] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:019 [7920] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:049 [7920] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:30:049 [7920] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:30:049 [7920] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:30:439 [7920] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:30:489 [7920] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:30:509 [7920] DEBUG - OnBrowseDirectChildren returning success with 10 objects of 63 total
Jul 29, 2013 17:56:30:909 [9004] DEBUG - PlexMediaConnectDelegate::OnBrowseDirectChildren for '6c92851cf9dd318f244a' with filter 'av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@size,res@protocolInfo,res@duration,res@bitrate,av:containerClass,res@dlna:ifoFileURI' and sort '', paged as 60 + 10
Jul 29, 2013 17:56:30:909 [9004] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";
Jul 29, 2013 17:56:30:909 [9004] DEBUG - Mapped object 6c92851cf9dd318f244a to /library/sections/1/all part 0 on server http://127.0.0.1:32400/
Jul 29, 2013 17:56:30:909 [9004] DEBUG - Downloading document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:909 [9004] DEBUG - Cache hit for document http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:909 [9004] DEBUG - HTTP requesting to: http://127.0.0.1:324.../sections/1/all
Jul 29, 2013 17:56:30:929 [9004] DEBUG - Downloading document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:30:929 [9004] DEBUG - Cache hit for document http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:30:929 [9004] DEBUG - HTTP requesting to: http://127.0.0.1:324...120,108,121,109
Jul 29, 2013 17:56:31:319 [9004] INFO - Arrival II (1998): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:31:369 [9004] INFO - Dune (1984): no video metadata was available for directplay analysis
Jul 29, 2013 17:56:31:399 [9004] DEBUG - OnBrowseDirectChildren returning success with 3 objects of 63 total
Jul 29, 2013 17:56:39:549 [7540] DEBUG - GET for http://192.168.0.9:3...na-icon-260.png
Jul 29, 2013 17:56:39:549 [7540] DEBUG - Serving up mapped file: C:\Program Files (x86)\Plex\Plex Media Server\Resources\Graphics\dlna-icon-260.png
Jul 29, 2013 17:56:44:210 [8504] DEBUG - HEAD for http://192.168.0.9:3...bd0b8c/file.mp4
Jul 29, 2013 17:56:44:210 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:210 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:210 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:210 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:220 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:220 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:220 [8504] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:44:220 [8504] DEBUG - Responding HTTP/1.1 200
Jul 29, 2013 17:56:44:260 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=0-32767
Jul 29, 2013 17:56:44:260 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:260 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:260 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:260 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:260 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:270 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:44:300 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:320 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=32256-65535
Jul 29, 2013 17:56:44:320 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:320 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:320 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:320 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:320 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:330 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:330 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:330 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:330 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:330 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=6908000
Jul 29, 2013 17:56:44:350 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:360 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=65024-98303
Jul 29, 2013 17:56:44:360 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:360 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:360 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:360 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:360 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:370 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:370 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:380 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:380 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:380 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:390 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:410 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=97792-131071
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:410 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:410 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:430 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:430 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:430 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:440 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:460 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=130560-163839
Jul 29, 2013 17:56:44:460 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:460 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:460 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:460 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:460 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:470 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:470 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:470 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:470 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:470 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:490 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:500 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=163328-196607
Jul 29, 2013 17:56:44:500 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:500 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:500 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:500 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:500 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:510 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:510 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:510 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:510 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:510 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:530 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:550 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=196096-229375
Jul 29, 2013 17:56:44:550 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:550 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:550 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:550 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:550 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:560 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:560 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:560 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:560 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:560 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:590 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:610 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=228864-262143
Jul 29, 2013 17:56:44:610 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:610 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:610 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:610 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:610 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:620 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:620 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:620 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:620 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:620 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:640 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:660 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=261632-294911
Jul 29, 2013 17:56:44:660 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:660 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:660 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:660 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:660 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:670 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:670 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:670 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:670 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:670 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:700 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:710 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=294400-327679
Jul 29, 2013 17:56:44:710 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:710 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:710 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:710 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:710 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:720 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:720 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:720 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:720 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:720 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:740 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:44:760 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=327168-360447
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:760 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:44:760 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:44:770 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:770 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:44:770 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=7127000
Jul 29, 2013 17:56:44:790 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=7127000
Jul 29, 2013 17:56:45:310 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=0-
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:310 [8504] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:45:310 [8504] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:45:320 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:45:320 [8504] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:45:320 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:45:860 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...opped&time=6000
Jul 29, 2013 17:56:45:980 [6368] DEBUG - HEAD for http://192.168.0.9:3...bd0b8c/file.mp4
Jul 29, 2013 17:56:45:980 [6368] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:45:980 [6368] DEBUG - Mapped object 68e20d8715e1a0bd0b8c to /library/metadata/6 part 0 on server
Jul 29, 2013 17:56:45:980 [6368] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:980 [6368] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:980 [6368] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/6
Jul 29, 2013 17:56:45:990 [6368] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/6 as 0abff47fd709b6f4780b83099582044e2abe22da
Jul 29, 2013 17:56:45:990 [6368] DEBUG - Serving up item /library/metadata/6 part 0
Jul 29, 2013 17:56:45:990 [6368] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:45:990 [6368] DEBUG - Responding HTTP/1.1 200
Jul 29, 2013 17:56:51:640 [1520] DEBUG - HEAD for http://192.168.0.9:3...7515ed/file.mp4
Jul 29, 2013 17:56:51:640 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:640 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:640 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:640 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:640 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:640 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:650 [1520] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:51:650 [1520] DEBUG - Responding HTTP/1.1 200
Jul 29, 2013 17:56:51:660 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=0-32767
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:660 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:660 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:660 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:51:690 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:710 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=32256-65535
Jul 29, 2013 17:56:51:710 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:710 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:710 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:710 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:710 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:720 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:720 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:720 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:720 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:720 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=9949000
Jul 29, 2013 17:56:51:730 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:740 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=65024-98303
Jul 29, 2013 17:56:51:740 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:740 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:740 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:740 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:740 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:750 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:750 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:750 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:750 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:750 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:770 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:790 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=97792-131071
Jul 29, 2013 17:56:51:790 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:790 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:790 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:790 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:790 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:800 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:800 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:800 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:800 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:800 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:820 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:830 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=130560-163839
Jul 29, 2013 17:56:51:830 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:830 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:830 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:830 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:830 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:840 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:840 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:840 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:840 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:840 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:860 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:870 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=163328-196607
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:870 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:870 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:880 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:880 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:880 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:890 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:910 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=196096-229375
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:910 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:910 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:920 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:930 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:940 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=228864-262143
Jul 29, 2013 17:56:51:940 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:940 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:940 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:940 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:940 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:950 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:950 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:950 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:950 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:950 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:51:960 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:51:970 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=261632-294911
Jul 29, 2013 17:56:51:970 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:51:980 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:51:980 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:980 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:980 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:51:990 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:51:990 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:51:990 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:51:990 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:51:990 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:52:000 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:52:010 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=294400-327679
Jul 29, 2013 17:56:52:010 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:52:010 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:52:010 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:010 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:010 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:020 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:52:020 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:52:020 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:52:020 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:52:020 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:52:040 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:52:050 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=327168-360447
Jul 29, 2013 17:56:52:050 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:52:050 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:52:050 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:050 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:050 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:060 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:52:060 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:52:070 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:52:070 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:52:070 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...g&time=10264000
Jul 29, 2013 17:56:52:090 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...d&time=10264000
Jul 29, 2013 17:56:52:230 [1520] DEBUG - GET for http://192.168.0.9:3...7515ed/file.mp4 : bytes=0-
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:230 [1520] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:52:230 [1520] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:52:240 [1520] DEBUG - Proxied GET to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:52:240 [1520] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:52:240 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:52:560 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...opped&time=5000
Jul 29, 2013 17:56:52:560 [0928] DEBUG - HEAD for http://192.168.0.9:3...7515ed/file.mp4
Jul 29, 2013 17:56:52:560 [0928] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:52:560 [0928] DEBUG - Mapped object f471a049a12dc67515ed to /library/metadata/7 part 0 on server
Jul 29, 2013 17:56:52:560 [0928] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:560 [0928] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:560 [0928] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/7
Jul 29, 2013 17:56:52:570 [0928] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/7 as 56e341224074617fbfcb4ed3933b1ebb65eb4a54
Jul 29, 2013 17:56:52:570 [0928] DEBUG - Serving up item /library/metadata/7 part 0
Jul 29, 2013 17:56:52:580 [0928] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/7/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:52:580 [0928] DEBUG - Responding HTTP/1.1 200
Jul 29, 2013 17:56:57:911 [6960] DEBUG - HEAD for http://192.168.0.9:3...24e8fa/file.mp4
Jul 29, 2013 17:56:57:911 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:57:911 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:57:911 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:57:911 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:57:921 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:57:921 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:57:921 [6960] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:57:921 [6960] DEBUG - Responding HTTP/1.1 200
Jul 29, 2013 17:56:57:931 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=0-32767
Jul 29, 2013 17:56:57:931 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:57:931 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:57:931 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:57:931 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:57:931 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:57:941 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:57:941 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:57:941 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:57:941 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:57:941 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:57:981 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:001 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=32256-65535
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:001 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:001 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:011 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:011 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:011 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5793000
Jul 29, 2013 17:56:58:011 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:041 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=65024-98303
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:041 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Purging document http://127.0.0.1:32400/ from the cache.
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Purging document http://127.0.0.1:324...120,108,121,109 from the cache.
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Purging document http://127.0.0.1:324...ibrary/sections from the cache.
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Purging document http://127.0.0.1:324...rary/sections/1 from the cache.
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Purging document http://127.0.0.1:324.../sections/1/all from the cache.
Jul 29, 2013 17:56:58:041 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:051 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:051 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:051 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:071 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:081 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=97792-131071
Jul 29, 2013 17:56:58:081 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:081 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:081 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:081 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:081 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:091 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:091 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:091 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:091 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:091 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:101 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:131 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=130560-163839
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:131 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:131 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:141 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:141 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:141 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:151 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:181 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=163328-196607
Jul 29, 2013 17:56:58:181 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:181 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:181 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:181 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:181 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:191 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:191 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:191 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:191 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:191 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:211 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:231 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=196096-229375
Jul 29, 2013 17:56:58:231 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:231 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:231 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:231 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:231 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:241 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:241 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:251 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:251 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:251 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:271 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:281 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=228864-262143
Jul 29, 2013 17:56:58:281 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:281 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:281 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:281 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:281 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:291 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:291 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:291 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:291 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:291 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:311 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:321 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=261632-294911
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:321 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:321 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:331 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:331 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:331 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:341 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:351 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=294400-327679
Jul 29, 2013 17:56:58:351 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:351 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:351 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:351 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:351 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:361 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:361 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:361 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:361 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:361 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:381 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:391 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=327168-360447
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:391 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:391 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:401 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:401 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:401 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ng&time=5976000
Jul 29, 2013 17:56:58:401 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...ed&time=5976000
Jul 29, 2013 17:56:58:541 [6960] DEBUG - GET for http://192.168.0.9:3...24e8fa/file.mp4 : bytes=0-
Jul 29, 2013 17:56:58:541 [6960] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:541 [6960] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:541 [6960] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:541 [6960] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:541 [6960] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:561 [6960] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:561 [6960] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:58:561 [6960] DEBUG - Proxied GET to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:58:561 [6960] DEBUG - Responding HTTP/1.1 206
Jul 29, 2013 17:56:58:561 [8304] DEBUG - HTTP requesting to: http://127.0.0.1:324...aying&time=1000
Jul 29, 2013 17:56:58:971 [7656] DEBUG - HTTP requesting to: http://127.0.0.1:324...opped&time=6000
Jul 29, 2013 17:56:58:981 [7104] DEBUG - HEAD for http://192.168.0.9:3...24e8fa/file.mp4
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Mapped object 5447be0be1b54724e8fa to /library/metadata/9 part 0 on server
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Downloading document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Cache hit for document http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:991 [7104] DEBUG - HTTP requesting to: http://127.0.0.1:324...rary/metadata/9
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Caching document http://127.0.0.1:324...rary/metadata/9 as 608ef19ae3e27a9677a8c4663a818763ba30a605
Jul 29, 2013 17:56:58:991 [7104] DEBUG - Serving up item /library/metadata/9 part 0
Jul 29, 2013 17:56:59:001 [7104] DEBUG - Proxied HEAD to http://127.0.0.1:324...rts/9/file.m4v: HTTP/1.0 200
Jul 29, 2013 17:56:59:001 [7104] DEBUG - Responding HTTP/1.1 200
 



#18 mfeingol

mfeingol

    Plex Dev Team

  • Plex Employee
  • PipPipPipPipPipPip
  • 3950 posts
  • Location: Redmond

Posted 30 July 2013 - 07:00 PM

Well, let's pick and random request sequence and see what happens:

BR issues a HEAD for a given MP4 file. This means it's a DirectPlay scenario; otherwise the file would be .ts. And we mapped the client to the right profile, so that's good:

Jul 29, 2013 17:56:44:210 [8504] DEBUG - HEAD for http://192.168.0.9:3...bd0b8c/file.mp4
Jul 29, 2013 17:56:44:210 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
...
Jul 29, 2013 17:56:44:220 [8504] DEBUG - Responding HTTP/1.1 200

The BR player seems to have liked the response, because now it's asking for the first 32kB of the file's content. The DLNA server process proxies that request into core PMS, and returns the right success code (206):

Jul 29, 2013 17:56:44:260 [8504] DEBUG - GET for http://192.168.0.9:3...bd0b8c/file.mp4 : bytes=0-32767
Jul 29, 2013 17:56:44:260 [8504] DEBUG - Mapped client to profile Sony Blu-ray using header X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"
...
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Proxied GET to http://127.0.0.1:324...rts/6/file.m4v: HTTP/1.1 206
Jul 29, 2013 17:56:44:270 [8504] DEBUG - Responding HTTP/1.1 206

Now, this happens for several different videos. What I believe is happening here is that the BR player is playing a few frames from each video to present thumbnails to the user. Why it wants to do this vs. simply using standard DLNA thumbnails is a question for Sony. But anyway, I see no failing requests in your log, so I can only conclude there's something in the metadata we're sending the BR player that it doesn't like, causing it to refuse to play the video later.

This is a hard one to debug, because sometimes the issue isn't necessarily what we're doing; it might be something we're not doing. Each device seems to have a special song and dance that's needed before it'll actually play a file.

So... What I'd do if I had this device in my office is I'd install Serviio or PS3MS (or any media player that works with it) and I'd do an A/B comparison of the HTTP and SOAP exchanges between the device and the media servers, using Wireshark. This does take time and expertise, but sometimes it's the only way to solve the problem.

I was doing this for a 2013 Bravia the other day, and I finally got it to work after finding the right way to lie to the TV (literally). But it took a couple of hours of trial and error.

#19 eklynner

eklynner

    Newbie

  • Members
  • Pip
  • 7 posts

Posted 14 August 2013 - 08:40 PM

I do have a question tho kind of a piggy back of my own thread, Do profiles seem to work for anyone when looking at movies all I get are just blue icons not the DVD covers? is there a seperate profile somewhere that i need to load for my player?



#20 SirWeazel

SirWeazel

    Member

  • Members
  • PipPip
  • 10 posts

Posted 28 August 2013 - 03:37 PM

Any update on this? I also experience this problem. If you need any further info let me know. With older versions of plex i could stream no problem using DLNA. I don't know what version it broke since i recently rebuilt my server after it was out of commission for a couple months.

 

Ubuntu 13.04, Plex 9.7.28, Sony BDP-s390 Blu Ray player.

 

Thanks in advance for any and all help.