Hello,
I just set up Plex Media Server (CentOS 6.x) + Rasplex (Pi) for the first time this weekend to replace my current setup of samba + NFS + raspmbc (on the Pi). So far, I am impressed and I see lots of benefits (mostly interface and metadata) over my previous setup.
Here's a high-level hardware/setup:
* Plex Media Server
- Intel iCore Duo 2.5Ghz
- 4GB RAM
- RAID-5 4+1 for media storage
- Gigabit ethernet (wired)
* Rasplex
- Raspberry Pi Model B v1
- 256MB RAM
- 8GB SDHC
- 10/100 ethernet (wired in, not using USB wifi)
- Doing direct play --- no monkeying with transcoding or quality settings
- Pre-cache warm-up is complete with cache space set at 15%
Both devices are on the same subnetted address space (on a /26 private class C)
I can direct play video through the Plex web interface without a problem --- works great. I have yet to try the iOS Plex client app, yet, for my iPhone + iPad mini.
What I cannot do is play any video what-so-ever from Rasplex. Any video I select to play I get, "Playback failed. One or more items failed to play. Check the log for more details." pop-up on the GUI client. Below are the log file outputs from PMS and Rasplex.
------------------------------------------------------------------------
Rasplex - /storage/.plexht/temp/plexhometheater.log
-------------------------------------------------------------------------
22:01:51 T:3045707776 NOTICE: Previous line repeats 6 times. 22:01:51 T:3045707776 ERROR: Keymapping error: no such action '-' defined 22:01:53 T:3045707776 ERROR: Previous line repeats 1 times. 22:01:53 T:3045707776 NOTICE: COMXPlayer: Opening: http://192.168.0.2:32400/library/parts/154/file.avi 22:01:53 T:2878874720 NOTICE: Thread COMXPlayer start, auto delete: false 22:01:53 T:2853708896 NOTICE: PlexDirectory::GetDirectory(http://192.168.0.2:32400/library/metadata/150?checkFiles=1) 22:01:53 T:2878874720 NOTICE: Creating InputStream 22:01:53 T:2878874720 ERROR: Open - Unhandled exception 22:01:53 T:2878874720 ERROR: Open - Error opening http://192.168.0.2:32400/library/parts/154/file.avi 22:01:53 T:2878874720 ERROR: COMXPlayer::OpenInputStream - error opening [192.168.0.2:32400/library/parts/154/file.avi] 22:01:53 T:2878874720 NOTICE: COMXPlayer::OnExit() 22:01:53 T:2878874720 NOTICE: COMXPlayer::OnExit() deleting input stream 22:01:53 T:3045707776 ERROR: Playlist Player: skipping unplayable item: 0, path [192.168.0.2:32400/library/parts/154/file.avi] 22:01:53 T:3045707776 WARNING: CreateFile, successfuly opened instead of 22:01:53 T:3045704800 NOTICE: Plex Media Server Queue: http://192.168.0.2:32400/:/progress?key=150&identifier=com.plexapp.plugins.library&time=0&state=stopped 22:01:53 T:3045707776 NOTICE: OMXClock using video as reference 22:01:57 T:3008361568 NOTICE: Previous line repeats 1 times. 22:01:57 T:3008361568 NOTICE: PlexDirectory::GetDirectory(http://192.168.0.2:32400)
---------------------------------------
Plex Media Server
---------------------------------------
Nov 10, 2013 16:20:50 [0x7f3692c77700] DEBUG - It took 0.000000 sec to serialize a list with 11 elements. Nov 10, 2013 16:20:50 [0x7f3692c77700] VERBOSE - Completed request: HEAD /: 200 Nov 10, 2013 16:20:50 [0x7f36ced69700] VERBOSE - Finished writing response for HEAD /, 0 bytes in 10112ms Nov 10, 2013 16:20:50 [0x7f36922b3700] DEBUG - Request: GET / [192.168.0.27:58051] (3 live) Nov 10, 2013 16:20:50 [0x7f36922b3700] DEBUG - It took 0.000000 sec to serialize a list with 11 elements. Nov 10, 2013 16:20:50 [0x7f36922b3700] VERBOSE - Completed request: GET /: 206 Nov 10, 2013 16:20:50 [0x7f36ced69700] VERBOSE - Finished writing response for GET /, 0 bytes in 21ms Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - Request: GET /library/metadata/150?checkFiles=1 [192.168.0.27:58052] (3 live) Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - * checkFiles => 1 Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - Request range: 0 to 0 Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - It took 0.000000 sec to serialize a list with 1 elements. Nov 10, 2013 16:20:56 [0x7f3692c77700] VERBOSE - Completed request: GET /library/metadata/150?checkFiles=1: 206 Nov 10, 2013 16:20:56 [0x7f36ced69700] VERBOSE - Finished writing response for GET /library/metadata/150?checkFiles=1, 0 bytes in 5754ms Nov 10, 2013 16:20:56 [0x7f36922b3700] DEBUG - Request: HEAD /library/parts/154/file.avi [192.168.0.27:58053] (3 live) Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - [IDLE] Adding (0->1) work item http_download - /library/parts/154/file.avi Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - [IDLE] Server is now active Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - [IDLE] * http_download - /library/parts/154/file.avi - 1 active item(s) Nov 10, 2013 16:20:56 [0x7f36922b3700] DEBUG - Content-Length of /data/raid/video/movies/Uncle Buck (1989)/Uncle Buck.avi is 734332928. Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - Completed request: HEAD /library/parts/154/file.avi: 200 Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - Request: GET /:/progress?key=150&identifier=com.plexapp.plugins.library&time=0&state=stopped [192.168.0.27:58054] (3 live) Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - * key => 150 Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - * identifier => com.plexapp.plugins.library Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - * time => 0 Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - * state => stopped Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - [IDLE] Removing (1->0) work item http_download - /library/parts/154/file.avi Nov 10, 2013 16:20:56 [0x7f36922b3700] VERBOSE - [IDLE] Server is now idle Nov 10, 2013 16:20:56 [0x7f3692c77700] DEBUG - Request range: 0 to 0 Nov 10, 2013 16:20:56 [0x7f3692c77700] WARN - Couldn't set play progress on item 150 Nov 10, 2013 16:20:56 [0x7f3692c77700] VERBOSE - Completed request: GET /:/progress?key=150&identifier=com.plexapp.plugins.library&time=0&state=stopped: 206 Nov 10, 2013 16:20:56 [0x7f36ced69700] VERBOSE - Finished writing response for GET /:/progress?key=150&identifier=com.plexapp.plugins.library&time=0&state=stopped, 0 bytes in 137ms Nov 10, 2013 16:20:57 [0x7f36922b3700] DEBUG - Request: GET / [192.168.0.27:58055] (3 live) Nov 10, 2013 16:20:57 [0x7f36922b3700] DEBUG - It took 0.000000 sec to serialize a list with 11 elements. Nov 10, 2013 16:20:57 [0x7f36922b3700] VERBOSE - Completed request: GET /: 206 Nov 10, 2013 16:20:57 [0x7f36ce3a5700] VERBOSE - Finished writing response for GET /, 0 bytes in 1339ms Nov 10, 2013 16:21:00 [0x7f3692c77700] DEBUG - Request: HEAD / [192.168.0.27:58057] (3 live) Nov 10, 2013 16:21:00 [0x7f3692c77700] DEBUG - It took 0.000000 sec to serialize a list with 11 elements. Nov 10, 2013 16:21:00 [0x7f3692c77700] VERBOSE - Completed request: HEAD /: 200 Nov 10, 2013 16:21:00 [0x7f36ce3a5700] VERBOSE - Finished writing response for HEAD /, 0 bytes in 2809ms
Other than the exception I see during the REST call to fetch the video to play, I'm just failing to see what other things I can look at to get this client to do playback --- the logs in debug or verbose really aren't giving me much else to go on --- not able to really see any proper exception dump or way to make this output more debug. I'm not sure what else I can really trace from a client-side perspective.
Any help or nudge in any positive direction is appreciated.