Linux: Server crash when playing show

Plex Media Server
1

Server Version#: 1.19.3.2852-219a9974e
Player Version#:
When playing a certain TV Show plex crashed. I was able to retrieve this from the logs

2020-05-26 21:20:32,551 (7fc3a97fa700) :  DEBUG (runtime:1156) - Starting timed thread named 'refresh_servers'
2020-05-26 21:20:32,552 (7fc3a97fa700) :  DEBUG (peerservice:164) - Fetching the current list of servers
2020-05-26 21:20:32,552 (7fc3a97fa700) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/servers'
2020-05-26 21:20:32,554 (7fc3a97fa700) :  CRITICAL (runtime:1128) - Exception in thread named 'refresh_servers' (most recent call last):
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1126, in _start_thread
    f(*args, **kwargs)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/System.bundle/Contents/Code/peerservice.py", line 169, in refresh_servers
    servers_el = self.get_servers_el()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/System.bundle/Contents/Code/peerservice.py", line 165, in get_servers_el
    return XML.ElementFromURL('http://127.0.0.1:32400/servers', cacheTime = 0)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/parsekit.py", line 344, in ElementFromURL
    method=method,
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/networkkit.py", line 67, in _http_request
    req = self._core.networking.http_request(url, *args, **kwargs)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 346, in http_request
    return HTTPRequest(self._core, url, data, h, url_cache, encoding, errors, timeout, immediate, sleep, opener, follow_redirects, method)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 118, in __init__
    self.load()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 158, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 429, in open
    response = self._open(req, data)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 447, in _open
    '_open', req)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 1228, in http_open
    return self.do_open(httplib.HTTPConnection, req)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 1198, in do_open
    raise URLError(err)
URLError: <urlopen error [Errno 111] Connection refused>
2

May I see the full logs ZIP please?

It’s impossible to debug from a snippet.

If necessary, please recreate and capture as soon as it fails.

3

Indeed you may, thank you

Plex Media Server Logs_2020-05-26_21-37-56.zip (1.4 MB)

4

Which log file did you find that error please?

I cannot find it.

5

com.plexapp.system.log.5

renamed and uploaded here

com.plexapp.system.log (42.2 KB)

6

thanks. I didn’t think to go that far back in the System.bundle.

It’s trying to refresh the list of owned and shared servers.
One of them is denying access (hard refuse) for TCP.

That’s not making sense because the server is running and showing in the list but a query to it and it’s denied?

How many servers are involved here?

2020-05-26 21:20:32,551 (7fc3a97fa700) :  DEBUG (runtime:1156) - Starting timed thread named 'refresh_servers'
2020-05-26 21:20:32,552 (7fc3a97fa700) :  DEBUG (peerservice:164) - Fetching the current list of servers
2020-05-26 21:20:32,552 (7fc3a97fa700) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/servers'
2020-05-26 21:20:32,554 (7fc3a97fa700) :  CRITICAL (runtime:1128) - Exception in thread named 'refresh_servers' (most recent call last):
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1126, in _start_thread
    f(*args, **kwargs)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/System.bundle/Contents/Code/peerservice.py", line 169, in refresh_servers
    servers_el = self.get_servers_el()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/System.bundle/Contents/Code/peerservice.py", line 165, in get_servers_el
    return XML.ElementFromURL('http://127.0.0.1:32400/servers', cacheTime = 0)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/parsekit.py", line 344, in ElementFromURL
    method=method,
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/networkkit.py", line 67, in _http_request
    req = self._core.networking.http_request(url, *args, **kwargs)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 346, in http_request
    return HTTPRequest(self._core, url, data, h, url_cache, encoding, errors, timeout, immediate, sleep, opener, follow_redirects, method)
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 118, in __init__
    self.load()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-219a9974e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 158, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 429, in open
    response = self._open(req, data)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 447, in _open
    '_open', req)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 1228, in http_open
    return self.do_open(httplib.HTTPConnection, req)
  File "/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/urllib2.py", line 1198, in do_open
    raise URLError(err)
URLError: <urlopen error [Errno 111] Connection refused>
7

I own 1 server and have shared access to another.
Think I narrowed it down to playing a certain shows.

I’ve since upgraded to latest for Plex Pass members and have not had the chance to try and play the same episode again. Once streamers goes offline I’ll give it another shot.

Thank you for taking the time to help

8

Hi @ChuckPa,

Would appreciate if you could revisit this thread again.

I’ve attahced the most recent log with another crash event upon playing mediaPlex Media Server Logs_2020-06-03_17-17-46.zip (2.4 MB)

9

I’m not sure what the situation is here but I see a remote playback starting but, before playback can begin, the client (device/player) closes the connection.

Jun 03, 2020 17:12:09.566 [0x7f145effd700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 03, 2020 17:12:10.332 [0x7f147c82f700] DEBUG - WebSocket: client initiated close
Jun 03, 2020 17:12:10.332 [0x7f147c82f700] DEBUG - handleStreamRead code 1: stream truncated
Jun 03, 2020 17:12:10.332 [0x7f147c82f700] DEBUG - NotificationStream: Removing because of error
Jun 03, 2020 17:12:10.332 [0x7f147c82f700] DEBUG - Completed after connection close: [XX.XX.XX.114:50037] -3 GET /:/websockets/notifications (9 live) TLS GZIP 119453ms 10428 bytes
Jun 03, 2020 17:12:11.308 [0x7f147c82f700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.308 [0x7f143affd700] DEBUG - Request: [XX.XX.XX.114:50096 (WAN)] GET /media/providers (8 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.310 [0x7f147d030700] DEBUG - Completed: [xx.xx.xx.114:50096] 200 GET /media/providers (8 live) TLS GZIP 1ms 4169 bytes (pipelined: 2)
Jun 03, 2020 17:12:11.434 [0x7f147c82f700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.434 [0x7f143affd700] DEBUG - Request: [xx.xx.xx.114:50096 (WAN)] GET /:/prefs (8 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.438 [0x7f147c82f700] DEBUG - Completed: [xx.xx.xx.114:50096] 200 GET /:/prefs (8 live) TLS GZIP 3ms 8670 bytes (pipelined: 3)
Jun 03, 2020 17:12:11.495 [0x7f147d030700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.495 [0x7f143affd700] DEBUG - Request: [xx.xx.xx.114:50096 (WAN)] GET /updater/status (10 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.495 [0x7f147c82f700] DEBUG - Completed: [87.61.80.114:50096] 200 GET /updater/status (10 live) TLS GZIP 0ms 518 bytes (pipelined: 4)
Jun 03, 2020 17:12:11.547 [0x7f147c82f700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.547 [0x7f143affd700] DEBUG - Request: [xx.xx.xx.114:50100 (WAN)] GET /status/sessions (11 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.547 [0x7f143affd700] DEBUG - [Now] Adding 0 sessions.
Jun 03, 2020 17:12:11.547 [0x7f147d030700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.547 [0x7f13f6ffd700] DEBUG - Request: [xx.xx.xx.114:50101 (WAN)] GET /:/websockets/notifications (11 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.547 [0x7f147d030700] DEBUG - Completed: [xx.xx.xx.114:50100] 200 GET /status/sessions (11 live) TLS GZIP 0ms 429 bytes (pipelined: 1)
Jun 03, 2020 17:12:11.547 [0x7f13f6ffd700] DEBUG - WebSocket: Performing handshake from origin https://app.plex.tv
Jun 03, 2020 17:12:11.547 [0x7f13f6ffd700] DEBUG - Beginning read from WebSocket
Jun 03, 2020 17:12:11.716 [0x7f147c82f700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.716 [0x7f143affd700] DEBUG - Request: [xx.xx.xx.114:50100 (WAN)] PUT /updater/check?download=0 (11 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.716 [0x7f143affd700] DEBUG - AutoUpdate: requesting check endpoint: /updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.19.4.2902-69560ce1e, download: NO
Jun 03, 2020 17:12:11.716 [0x7f143affd700] DEBUG - Downloading document https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.19.4.2902-69560ce1e
Jun 03, 2020 17:12:11.716 [0x7f143affd700] DEBUG - HTTP requesting GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.19.4.2902-69560ce1e
Jun 03, 2020 17:12:11.727 [0x7f147d030700] DEBUG - Auth: authenticated user 1 as Moxs
Jun 03, 2020 17:12:11.727 [0x7f13f6ffd700] DEBUG - Request: [xx.xx.xx.114:50096 (WAN)] GET /activities (11 live) TLS GZIP Signed-in Token (Moxs)
Jun 03, 2020 17:12:11.727 [0x7f147d030700] DEBUG - Completed: [xx.xx.xx.114:50096] 200 GET /activities (11 live) TLS GZIP 0ms 429 bytes (pipelined: 5)
Jun 03, 2020 17:12:11.863 [0x7f143affd700] DEBUG - HTTP 200 response from GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.19.4.2902-69560ce1e
Jun 03, 2020 17:12:11.863 [0x7f143affd700] INFO - AutoUpdate: no updates available
Jun 03, 2020 17:12:11.863 [0x7f147d030700] DEBUG - Completed: [xx.xx.xx.114:50100] 200 PUT /updater/check?download=0 (11 live) TLS GZIP 147ms 274 bytes (pipelined: 2)
Jun 03, 2020 17:12:12.262 [0x7f147c82f700] DEBUG - handleStreamRead code 104: Connection reset by peer
Jun 03, 2020 17:12:12.262 [0x7f147c82f700] DEBUG - NotificationStream: Removing because of error
Jun 03, 2020 17:12:12.263 [0x7f147c82f700] DEBUG - Completed after connection close: [192.38.130.158:4646] -3 GET /:/websockets/notifications (11 live) TLS GZIP 819840ms 243 bytes
Jun 03, 2020 17:12:16.332 [0x7f147c82f700] DEBUG - Auth: authenticated user 1 as Moxs

Should the connection be WAN? The player is distant from the server?

10

The player is remote, my tv.
It’s strange, deleting the content, rescan plex lib, and adding the content again plays just fine.

My setup:
Dedicated hetzner server. Media stored on Google drive.
Playing remote

11

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.