Plex Media Server unstable won't run anymore?

Kaya Saman kayasaman at gmail.com
Wed Apr 30 14:26:43 UTC 2014


Hi,

I'm running 10.0-RELEASE on amd64 and for some reason Plex Media Server 
doesn't want to fire up any more?

Running ps aux |grep plex

only these can be seen after /usr/local/etc/rc.d/plexmediaserver


plex    110   0.0  0.6 223992  52988  -  SN    3:11PM     0:03.07 Plex 
Plug-in [com.plexapp.system] /usr/local/plexdata/Plex Media 
Server/Plug-ins/F
plex    115   0.0  0.3 183660  25368  -  S     3:11PM     0:00.67 
/usr/local/share/plexmediaserver/Plex DLNA Server


Also I've noticed a few core dumps too and additionally the Channels 
don't seem to work from within the web client or even when using a 
remote PlexHomeTheater client on a Linux box. The Android app seems to 
work fine though.....

I'm not sure what is going on and I've even been on the Plex FreeBSD 
forum asking for help but I got sent here from there.... Also I don't 
know if it's relevant but I was told that there is an update for PMS 
though it doesn't seem to be translated to FreeBSD yet. I'm wondering if 
there are bug fixes with the newer version, that perhaps I'm running 
into on my version?

This is my version:

plexmediaserver-0.9.9.4.409_2  The Plex Media Server component

plexmediaserver-0.9.9.4.409_2  The Plex Media Server component

The actual h/w is a Xeon E5 with 8GB RAM and 16GB of Swap so should be 
plenty to run Plex.


Basically I've had to 'kill' the process a few times as it was hanging; 
/usr/local/etc/rc.d/plexmediaserver stop wasn't able to shut the 
processes down while the Media Service was actually showing up under 'ps'.

Here's the output of the logs:


Apr 30, 2014 15:11:10 [0x807806400] DEBUG - Checking for blacklisted 
version for Framework.bundle (version 279a6af)
Apr 30, 2014 15:11:10 [0x807806400] DEBUG - Checking for blacklisted 
version for System.bundle (version c259f60)
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - File 
/usr/local/plexdata/Plex Media Server/Plug-ins changed: -1 => 1398833726.
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - Scanning for plug-ins in 
/usr/local/plexdata/Plex Media Server/Plug-ins
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - Starting plug-in 
/usr/local/plexdata/Plex Media Server/Plug-ins/System.bundle.
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - [com.plexapp.system] Setting 
plug-in to always running (daemon mode).
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - Starting file watcher for 
com.plexapp.system
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - Spawned plug-in 
com.plexapp.system with PID 110
Apr 30, 2014 15:11:10 [0x80780b400] DEBUG - [com.plexapp.system] Sent 
command: GET /:/prefixes
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - Reading 486 bytes in the 
body, code is 200
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - [com.plexapp.system] Plug-in 
running on port 49012.
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG -  * Plug-in handles prefix: 
/system
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG -  * Plug-in handles prefix: 
/player
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - Read configuration for 
[com.plexapp.system], had 2 prefixes
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - Done with 1 synchronous 
plug-in starts, starting the rest in parallel.
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - Updating the list of agents 
known by the system.
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - [com.plexapp.system] Sending 
command over HTTP (GET): /system/agents
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - Image transcode cache 
directory: /usr/local/plexdata/Plex Media Server/Cache/PhotoTranscoder
Apr 30, 2014 15:11:12 [0x80780b400] DEBUG - HTTP requesting to: 
http://127.0.0.1:49012/system/agents
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NAT: Starting Mapping Thread.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NAT: Using manually 
specified port of 32400.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NAT: Creating NAT puncher 
thread 0x807af9020
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - Creating NetworkServices 
singleton.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NetworkServices: Initializing...
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b6f000: Creating new 
Network Service and registering for notifications.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Updating mapping in 
puncher thread 0x807af9020
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Creating puncher.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Switching to NAT-PMP 
strategy.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b6f000: NetworkService 
got notification of changed network (first change: 1)
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NetworkService: Quick 
dispatch of network change.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Creating NATPmPPuncher.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b72000: Creating new 
Network Service and registering for notifications.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b72000: NetworkService 
got notification of changed network (first change: 1)
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NetworkService: Quick 
dispatch of network change.
Apr 30, 2014 15:11:12 [0x80780bc00] DEBUG - HTTP requesting to: 
https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b75000: Creating new 
Network Service and registering for notifications.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b75000: NetworkService 
got notification of changed network (first change: 1)
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NetworkService: Quick 
dispatch of network change.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Initializing NAT-PMP, 
success=1
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Finding public address 
failed the first way, switching.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Switching to UPnP strategy.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b78000: Creating new 
Network Service and registering for notifications.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - 0x807b78000: NetworkService 
got notification of changed network (first change: 1)
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - NetworkService: Quick 
dispatch of network change.
Apr 30, 2014 15:11:12 [0x80780c000] DEBUG - NAT: Creating NATUPnPPuncher.
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - Network change for advertiser.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - Starting HTTP server.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - Running server...
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - NetworkService: Setting up 
multicast listener on 0.0.0.0:32414 (outbound: 0)
Apr 30, 2014 15:11:12 [0x80780c800] DEBUG - DLNA server starting.
Apr 30, 2014 15:11:12 [0x807806400] DEBUG - Waiting for server condition 
to be signaled.
Apr 30, 2014 15:11:12 [0x80780c800] DEBUG - Job running: 
/usr/local/share/plexmediaserver/Plex DLNA Server
Apr 30, 2014 15:11:12 [0x80780cc00] DEBUG - Set up a thread pool for 
HTTP server with 2 threads.
Apr 30, 2014 15:11:12 [0x80780cc00] VERBOSE - [Event] Firing 
plex.event.server.startup to 2 sink(s)
Apr 30, 2014 15:11:12 [0x80780a400] ERROR - Couldn't add a new thread to 
the pool of size 1: boost thread: failed in pthread_create: Resource 
temporarily unavailable
Apr 30, 2014 15:11:12 [0x808445800] DEBUG - Request: [127.0.0.1:49008] 
GET 
/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ 
(5 live)
Apr 30, 2014 15:11:12 [0x808022800] DEBUG - Request: [127.0.0.1:49009] 
GET / (5 live)
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - Network change for advertiser.
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - NetworkService: Setting up 
multicast listener on 0.0.0.0:32410 (outbound: 0)
Apr 30, 2014 15:11:12 [0x808445400] DEBUG - Request: [127.0.0.1:49011] 
GET /servers (5 live)
Apr 30, 2014 15:11:12 [0x808445400] DEBUG - It took 0.000000 sec to 
serialize a list with 1 elements.
Apr 30, 2014 15:11:12 [0x808022800] DEBUG - It took 0.000000 sec to 
serialize a list with 11 elements.
Apr 30, 2014 15:11:12 [0x808445800] DEBUG - [com.plexapp.system] Sending 
command over HTTP (GET): 
/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Apr 30, 2014 15:11:12 [0x808022800] VERBOSE - Completed request: GET /: 2200
Apr 30, 2014 15:11:12 [0x808022800] DEBUG - Request: [127.0.0.1:49010] 
GET / (5 live)
Apr 30, 2014 15:11:12 [0x808445800] DEBUG - HTTP requesting to: 
http://127.0.0.1:49012/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - Network change for browser 
(polled=0), closing 0 browse sockets.
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - NetworkService: Setting up 
multicast listener on 0.0.0.0:32413 (outbound: 0)
Apr 30, 2014 15:11:12 [0x80780c400] DEBUG - Network change for browser 
(polled=1), closing 0 browse sockets.
Apr 30, 2014 15:11:12 [0x808022800] DEBUG - It took 0.000000 sec to 
serialize a list with 11 elements.
Apr 30, 2014 15:11:12 [0x80780a000] VERBOSE - Finished writing response 
for GET /, 0 bytes in 2ms
Apr 30, 2014 15:11:12 [0x808022800] VERBOSE - Completed request: GET /: 2200
Apr 30, 2014 15:11:12 [0x808445400] VERBOSE - Completed request: GET 
/servers: 2200
Apr 30, 2014 15:11:12 [0x80780a000] VERBOSE - Finished writing response 
for GET /, 0 bytes in 1ms
Apr 30, 2014 15:11:12 [0x80780a400] VERBOSE - Finished writing response 
for GET /servers, 0 bytes in 1ms


Any help would highly be appreciated.


Thanks.


Kaya


More information about the freebsd-ports mailing list