Server pegs to 100% CPU and randomly stops running

Jehly · November 21, 2022, 4:45pm

I recently noticed my server running on Ubuntu with a remote Synology NAS has started to peg at 100% when nothing is playing and seemingly no new media is being scrubbed/thumbnailed.

After a few hours, the server will no longer be discoverable but shows running still when I check Ubuntu service command line.

It’s been working for quite a while with no issues, then suddenly they started up. I’ve searched and searched but to no avail on the forums/reddit.

I’m not terribly talented when postings logs, so I’m not really sure how to. However, I noticed these few lines in the logs:

2022-11-21 08:26:21,352 (7f31a7a4db38) : ERROR (networking:196) - Error opening URL ‘http://resources-cdn.plexapp.com/hashes.json’
2022-11-21 08:26:21,352 (7f31a7a4db38) : CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
File “/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py”, line 1291, in get_resource_hashes
json = self._core.networking.http_request(“http://resources-cdn.plexapp.com/hashes.json”, timeout=5).content
File “/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py”, line 242, in content
return self.str()
File “/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py”, line 220, in str
self.load()
File “/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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/python27.zip/urllib2.py”, line 435, in open
response = meth(req, response)
File “/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py”, line 548, in http_response
‘http’, request, response, code, msg, hdrs)
File “/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py”, line 473, in error
return self._call_chain(*args)
File “/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py”, line 407, in _call_chain
result = func(*args)
File “/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py”, line 556, in http_error_default
raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 403: Forbidden

Server Version#:4.94.2
Player Version#:

ChuckPa · November 21, 2022, 5:16pm

Please download and attach the full log ZIP file which includes this.

It is not possible to diagnose from a posted snippet.

Jehly · November 21, 2022, 5:32pm

I wasn’t sure if there was a way to make it a little easier for you to read. I think it happened in this session because it’s happened twice since I’ve posted.

2022-11-21 08:38:27,192 (7f71a49ab808) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: f3f2fcc (Mon Nov 14 21:40:12 UTC 2022)
2022-11-21 08:38:27,192 (7f71a49ab808) :  DEBUG (core:361) - Using the elevated policy
2022-11-21 08:38:27,193 (7f71a49ab808) :  DEBUG (core:365) - Extending whitelist: ['cgi', 'tempfile']
2022-11-21 08:38:27,193 (7f71a49ab808) :  DEBUG (core:450) - Starting runtime component.
2022-11-21 08:38:27,194 (7f71a49ab808) :  DEBUG (core:450) - Starting caching component.
2022-11-21 08:38:27,194 (7f71a49ab808) :  DEBUG (core:450) - Starting data component.
2022-11-21 08:38:27,194 (7f71a49ab808) :  DEBUG (core:450) - Starting networking component.
2022-11-21 08:38:27,195 (7f71a49ab808) :  DEBUG (networking:261) - Loaded HTTP cookies
2022-11-21 08:38:27,195 (7f71a49ab808) :  DEBUG (networking:428) - Setting the default network timeout to 20.0
2022-11-21 08:38:27,196 (7f71a49ab808) :  DEBUG (core:450) - Starting localization component.
2022-11-21 08:38:27,196 (7f71a49ab808) :  INFO (localization:409) - Setting the default locale to en-us
2022-11-21 08:38:27,196 (7f71a49ab808) :  WARNING (data:179) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting property name enclosed in double quotes: line 26 column 1 (char 1078)
2022-11-21 08:38:27,197 (7f71a49ab808) :  DEBUG (localization:427) - Loaded en strings
2022-11-21 08:38:27,197 (7f71a49ab808) :  DEBUG (core:450) - Starting messaging component.
2022-11-21 08:38:27,197 (7f71a49ab808) :  DEBUG (core:450) - Starting debugging component.
2022-11-21 08:38:27,198 (7f71a49ab808) :  DEBUG (core:450) - Starting services component.
2022-11-21 08:38:27,198 (7f71a49ab808) :  DEBUG (core:450) - Starting myplex component.
2022-11-21 08:38:27,198 (7f71a49ab808) :  DEBUG (core:450) - Starting notifications component.
2022-11-21 08:38:27,294 (7f71a49ab808) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2022-11-21 08:38:27,314 (7f71a1615b38) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2022-11-21 08:38:27,314 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2022-11-21 08:38:27,315 (7f71a1615b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2022-11-21 08:38:27,316 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2022-11-21 08:38:27,317 (7f71a49ab808) :  DEBUG (core:150) - Finished starting framework core
2022-11-21 08:38:27,317 (7f71a49ab808) :  DEBUG (core:560) - Loading plug-in code
2022-11-21 08:38:27,317 (7f71a15cfb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400'
2022-11-21 08:38:27,318 (7f71a1615b38) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2022-11-21 08:38:27,318 (7f71a1615b38) :  ERROR (services:272) - Unable to load services from system. Loading from the current bundle only.
2022-11-21 08:38:27,328 (7f71a15cfb38) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400'
2022-11-21 08:38:27,329 (7f71a1615b38) :  DEBUG (services:362) - Loaded services
2022-11-21 08:38:27,329 (7f71a15cfb38) :  WARNING (core:541) - Unable to retrieve the machine identifier or server version.
2022-11-21 08:38:27,337 (7f71a15f2b38) :  DEBUG (services:438) - No shared code to load
2022-11-21 08:38:27,349 (7f71a49ab808) :  DEBUG (core:566) - Finished loading plug-in code
2022-11-21 08:38:27,349 (7f71a49ab808) :  DEBUG (runtime:640) - Adding a prefix handler for 'System' ('/system')
2022-11-21 08:38:27,907 (7f71a49ab808) :  INFO (__init__:35) - Starting System f3f2fcc (Mon Nov 14 21:40:12 UTC 2022)
2022-11-21 08:38:27,907 (7f71a49ab808) :  DEBUG (runtime:640) - Adding a prefix handler for 'Player' ('/player')
2022-11-21 08:38:27,911 (7f71a49ab808) :  INFO (datakit:93) - Loaded the dictionary file
2022-11-21 08:38:27,911 (7f71a49ab808) :  DEBUG (agentservice:52) - Starting the agent service
2022-11-21 08:38:27,999 (7f71a49ab808) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2022-11-21 08:38:28,005 (7f71a49ab808) :  DEBUG (bundleservice:65) - Starting the bundle service
2022-11-21 08:38:28,005 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'start'
2022-11-21 08:38:28,005 (7f71a49ab808) :  DEBUG (playerservice:12) - Starting the player service
2022-11-21 08:38:28,006 (7f71a49ab808) :  DEBUG (flagservice:13) - Starting the media flag service
2022-11-21 08:38:28,007 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,008 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,008 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'start'
2022-11-21 08:38:28,009 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,010 (7f71a49ab808) :  DEBUG (peerservice:141) - Starting the peer service
2022-11-21 08:38:28,012 (7f71a13f5b38) :  DEBUG (peerservice:164) - Fetching the current list of servers
2022-11-21 08:38:28,012 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'refresh_servers'
2022-11-21 08:38:28,013 (7f71a13f5b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/servers'
2022-11-21 08:38:28,013 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,013 (7f71a49ab808) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'refresh_servers'
2022-11-21 08:38:28,014 (7f71a49ab808) :  DEBUG (streamservice:18) - Starting the stream service
2022-11-21 08:38:28,014 (7f71a49ab808) :  CRITICAL (runtime:709) - Private handlers are no longer supported; couldn't register <bound method StreamService.token_handler of <streamservice.StreamService object at 0x7f71a1212c10>>
2022-11-21 08:38:28,014 (7f71a49ab808) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'invalidation_timer'
2022-11-21 08:38:28,015 (7f71a49ab808) :  DEBUG (proxyservice:12) - Starting the proxy service
2022-11-21 08:38:28,016 (7f71a13f5b38) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400/servers'
2022-11-21 08:38:28,018 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'update_attribution_flags_inner'
2022-11-21 08:38:28,018 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,019 (7f71a49ab808) :  INFO (core:611) - Started plug-in
2022-11-21 08:38:28,020 (7f71a49ab808) :  DEBUG (socketinterface:160) - Starting socket server
2022-11-21 08:38:28,022 (7f71a49ab808) :  DEBUG (runtime:1117) - Created a thread named 'start'
2022-11-21 08:38:28,022 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,024 (7f71a13f5b38) :  CRITICAL (runtime:1128) - Exception in thread named 'refresh_servers' (most recent call last):
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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-f3f2fcc0a/System.bundle/Contents/Code/peerservice.py", line 169, in refresh_servers
    servers_el = self.get_servers_el()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/parsekit.py", line 344, in ElementFromURL
    method=method,
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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-f3f2fcc0a/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-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 118, in __init__
    self.load()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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/python27.zip/urllib2.py", line 435, in open
    response = meth(req, response)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 548, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 473, in error
    return self._call_chain(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 556, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 503: Service Unavailable

2022-11-21 08:38:28,024 (7f71a49ab808) :  INFO (socketinterface:184) - Socket server started on port 43109
2022-11-21 08:38:28,025 (7f71a49ab808) :  INFO (pipeinterface:25) - Entering run loop
2022-11-21 08:38:28,025 (7f71a49ab808) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2022-11-21 08:38:28,026 (7f71a49ab808) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2022-11-21 08:38:28,028 (7f71a49ab808) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 486 bytes
2022-11-21 08:38:28,028 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,029 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,031 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,034 (7f71a143bb38) :  INFO (bundleservice:131) - Found duplicate identifier at /usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/WebClient.bundle for bundled plugin (com.plexapp.plugins.webclient), ignoring duplicate plugin.
2022-11-21 08:38:28,037 (7f71a13f5b38) :  DEBUG (runtime:717) - Handling request GET /system/agents
2022-11-21 08:38:28,048 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,054 (7f71a13f5b38) :  DEBUG (runtime:814) - Found route matching /system/agents
2022-11-21 08:38:28,055 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,056 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,056 (7f71a143bb38) :  INFO (bundleservice:131) - Found duplicate identifier at /usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/TheTVDBv4.bundle for bundled plugin (com.plexapp.agents.thetvdb), ignoring duplicate plugin.
2022-11-21 08:38:28,057 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,058 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,059 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,060 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,061 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,061 (7f71a143bb38) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2022-11-21 08:38:28,061 (7f71a143bb38) :  DEBUG (bundleservice:81) - Started the bundle service
2022-11-21 08:38:28,064 (7f71a1418b38) :  DEBUG (flagservice:46) - Started the media flag service
2022-11-21 08:38:28,069 (7f71a0e04b38) :  INFO (agentservice:129) - Agent info: {'com.plexapp.agents.fanarttv': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}], 'com.plexapp.agents.none': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Shows'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Artists'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Albums'}, {'media_types': ['Photo'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['en', 'ar', 'bg', 'ca', 'cs', 'cy', 'da', 'de', 'el', 'es', 'et', 'fa', 'fi', 'fr', 'he', 'hi', 'hr', 'ht', 'hu', 'id', 'it', 'ja', 'ko', 'lt', 'lv', 'ms', 'mt', 'nl', 'no', 'pl', 'pt', 'ro', 'ru', 'sk', 'sv', 'sl', 'sr', 'th', 'tr', 'uk', 'ur', 'vi', 'zh', 'xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Photos'}], 'tv.plex.agents.music': [{'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi', 'xx'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex Music'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi', 'xx'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex Music'}], 'com.plexapp.agents.opensubtitles': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}], 'com.plexapp.agents.imdb': [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'nl', 'de', 'it', 'da', 'ar', 'ca', 'zh', 'cs', 'et', 'fi', 'el', 'he', 'hi', 'hu', 'id', 'ja', 'ko', 'lv', 'no', 'fa', 'pl', 'pt', 'ro', 'ru', 'sk', 'th', 'tr', 'uk', 'vi'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex Movie'}], 'com.plexapp.agents.lyricfind': [{'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm', 'tv.plex.agents.music', 'org.musicbrainz.agents.music'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': False, 'name': 'LyricFind'}], 'com.plexapp.agents.thetvdb': [{'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'fr', 'zh', 'sv', 'no', 'da', 'fi', 'nl', 'de', 'it', 'es', 'pl', 'hu', 'el', 'tr', 'ru', 'he', 'ja', 'pt', 'cs', 'ko', 'sl', 'hr'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'TheTVDB'}], 'tv.plex.agents.movie': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': [], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex Movie'}], 'tv.plex.agents.series': [{'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': [], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex TV Series'}], 'com.plexapp.agents.lastfm': [{'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'de', 'pl', 'it', 'pt', 'ja', 'tr', 'ru', 'zh'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Last.fm'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'de', 'pl', 'it', 'pt', 'ja', 'tr', 'ru', 'zh'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Last.fm'}], 'org.musicbrainz.agents.music': [{'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi', 'xx'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Musicbrainz'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi', 'xx'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Musicbrainz'}], 'com.plexapp.agents.themoviedb': [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'cs', 'da', 'de', 'el', 'es', 'fi', 'fr', 'he', 'hr', 'hu', 'it', 'lv', 'lt', 'nl', 'no', 'pl', 'pt', 'ru', 'sk', 'sv', 'th', 'tr', 'vi', 'zh', 'ko'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'The Movie Database'}, {'media_types': ['TV_Show'], 'accepts_from': ['com.plexapp.agents.localmedia', 'com.plexapp.agents.thetvdb'], 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'has_attribution': True, 'languages': ['en', 'cs', 'da', 'de', 'el', 'es', 'fi', 'fr', 'he', 'hr', 'hu', 'it', 'lv', 'lt', 'nl', 'no', 'pl', 'pt', 'ru', 'sk', 'sv', 'th', 'tr', 'vi', 'zh', 'ko'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'The Movie Database'}], 'com.plexapp.agents.htbackdrops': [{'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['ab', 'aa', 'af', 'ak', 'sq', 'am', 'ar', 'an', 'hy', 'as', 'av', 'ae', 'ay', 'az', 'bm', 'ba', 'eu', 'be', 'bn', 'bh', 'bi', 'bs', 'pb', 'br', 'bg', 'my', 'ca', 'ch', 'ce', 'ny', 'zh', 'cu', 'cv', 'kw', 'co', 'cr', 'hr', 'cs', 'da', 'dv', 'nl', 'dz', 'en', 'eo', 'et', 'ee', 'fo', 'fj', 'fi', 'fr', 'fy', 'ff', 'gd', 'gl', 'lg', 'ka', 'de', 'el', 'gn', 'gu', 'ht', 'ha', 'he', 'hz', 'hi', 'ho', 'hu', 'is', 'io', 'ig', 'id', 'ia', 'ie', 'iu', 'ik', 'ga', 'it', 'ja', 'jv', 'kl', 'kn', 'kr', 'ks', 'kk', 'km', 'ki', 'rw', 'ky', 'kv', 'kg', 'ko', 'kj', 'ku', 'lo', 'la', 'lv', 'li', 'ln', 'lt', 'lu', 'lb', 'mk', 'mg', 'ms', 'ml', 'mt', 'gv', 'mi', 'mr', 'mh', 'mo', 'mn', 'na', 'nv', 'ng', 'ne', 'xn', 'nd', 'no', 'nb', 'nn', 'oc', 'oj', 'or', 'om', 'os', 'pi', 'pa', 'fa', 'pl', 'pt', 'ps', 'qu', 'rm', 'ro', 'rn', 'ru', 'se', 'sm', 'sg', 'sa', 'sc', 'sr', 'sn', 'ii', 'sd', 'si', 'sk', 'sl', 'so', 'st', 'nr', 'es', 'su', 'sw', 'ss', 'sv', 'tl', 'ty', 'tg', 'ta', 'tt', 'te', 'th', 'bo', 'ti', 'to', 'ts', 'tn', 'tr', 'tk', 'tw', 'ug', 'uk', 'ur', 'uz', 've', 'vi', 'vo', 'wa', 'cy', 'wo', 'xh', 'yi', 'yo', 'za', 'zu'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': False, 'name': 'Home Theater Backdrops'}], 'com.plexapp.agents.movieposterdb': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': False, 'name': 'CineMaterial'}], 'com.plexapp.agents.localmedia': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Movies)'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (TV)'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.discogs', 'com.plexapp.agents.lastfm', 'com.plexapp.agents.plexmusic', 'com.plexapp.agents.none', 'tv.plex.agents.music', 'org.musicbrainz.agents.music'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Artists)'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.plexmusic'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 2, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Artists)'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.discogs', 'com.plexapp.agents.lastfm', 'com.plexapp.agents.plexmusic', 'com.plexapp.agents.none', 'tv.plex.agents.music', 'org.musicbrainz.agents.music'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Albums)'}], 'com.plexapp.agents.plexthememusic': [{'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.thetvdbdvdorder', 'com.plexapp.agents.themoviedb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': False, 'name': 'Plex Theme Music'}]}
2022-11-21 08:38:28,083 (7f71a13f5b38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,084 (7f71a0e04b38) :  INFO (datakit:131) - Saved the dictionary file
2022-11-21 08:38:28,095 (7f71a13f5b38) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 11288 bytes
2022-11-21 08:38:28,096 (7f71a0cccb38) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2022-11-21 08:38:28,803 (7f71a1418b38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/resourceHashes
2022-11-21 08:38:28,812 (7f71a1418b38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/resourceHashes
2022-11-21 08:38:28,812 (7f71a1418b38) :  DEBUG (networking:143) - Requesting 'http://resources-cdn.plexapp.com/hashes.json'
2022-11-21 08:38:29,039 (7f71a1418b38) :  ERROR (networking:196) - Error opening URL 'http://resources-cdn.plexapp.com/hashes.json'
2022-11-21 08:38:29,039 (7f71a1418b38) :  CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1291, in get_resource_hashes
    json = self._core.networking.http_request("http://resources-cdn.plexapp.com/hashes.json", timeout=5).content
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 242, in content
    return self.__str__()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 220, in __str__
    self.load()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-f3f2fcc0a/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/python27.zip/urllib2.py", line 435, in open
    response = meth(req, response)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 548, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 473, in error
    return self._call_chain(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 556, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 403: Forbidden

2022-11-21 08:38:29,040 (7f71a1418b38) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2022-11-21 08:38:29,040 (7f71a1418b38) :  DEBUG (runtime:924) - Response: [404] NoneType, 0 bytes
2022-11-21 08:38:29,053 (7f71a1418b38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2022-11-21 08:38:29,054 (7f71a1418b38) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2022-11-21 08:38:29,055 (7f71a1418b38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2022-11-21 08:38:29,056 (7f71a1418b38) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2022-11-21 08:38:29,056 (7f71a1418b38) :  DEBUG (runtime:924) - Response: [200] str, 516 bytes
2022-11-21 08:38:29,696 (7f71a1418b38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2022-11-21 08:38:29,697 (7f71a1418b38) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2022-11-21 08:38:29,698 (7f71a1418b38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2022-11-21 08:38:29,699 (7f71a1418b38) :  INFO (agentservice:175) - Receiving agent info from com.plexapp.agents.imdb: [{'media_types': ['Movie'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.themoviedb'], 'languages': ['en', 'sv', 'fr', 'es', 'nl', 'de', 'it', 'da', 'ar', 'ca', 'zh', 'cs', 'et', 'fi', 'el', 'he', 'hi', 'hu', 'id', 'ja', 'ko', 'lv', 'no', 'fa', 'pl', 'pt', 'ro', 'ru', 'sk', 'th', 'tr', 'uk', 'vi'], 'persist_stored_files': True, 'version': 0, 'accepts_from': ['com.plexapp.agents.localmedia'], 'prefs': True, 'name': 'Plex Movie'}]
2022-11-21 08:38:29,700 (7f71a1418b38) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2022-11-21 08:38:29,700 (7f71a1418b38) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2022-11-21 08:38:31,197 (7f71a1418b38) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2022-11-21 08:38:31,198 (7f71a1418b38) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2022-11-21 08:38:31,199 (7f71a1418b38) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2022-11-21 08:38:31,200 (7f71a1418b38) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.system
2022-11-21 08:38:31,200 (7f71a1418b38) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2022-11-21 08:38:31,200 (7f71a1418b38) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2022-11-21 08:38:33,038 (7f71a1418b38) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=127.0.0.1
2022-11-21 08:38:33,073 (7f71a1418b38) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2022-11-21 08:38:33,073 (7f71a1418b38) :  DEBUG (peerservice:386) - Handling server update notification (127.0.0.1)
2022-11-21 08:38:33,074 (7f71a1418b38) :  DEBUG (peerservice:189) - Updating servers (True/False True/True/True)
2022-11-21 08:38:33,074 (7f71a1418b38) :  DEBUG (peerservice:164) - Fetching the current list of servers
2022-11-21 08:38:33,074 (7f71a1418b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/servers'
2022-11-21 08:38:33,076 (7f71a1418b38) :  DEBUG (peerservice:198) - Found 1 servers
2022-11-21 08:38:33,076 (7f71a1418b38) :  DEBUG (peerservice:214) - Ignoring 258bf455fafeb7e411ad5fafdbda4983ea3c9ed6 because host != 127.0.0.1 (192.168.1.250)
2022-11-21 08:38:33,077 (7f71a1418b38) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2022-11-21 08:38:33,090 (7f71a143bb38) :  INFO (datakit:131) - Saved the dictionary file
2022-11-21 08:40:28,015 (7f71a13d2b38) :  DEBUG (runtime:1156) - Starting timed thread named 'refresh_servers'
2022-11-21 08:40:28,015 (7f71a13d2b38) :  DEBUG (peerservice:164) - Fetching the current list of servers
2022-11-21 08:40:28,015 (7f71a13d2b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/servers'
2022-11-21 08:40:28,016 (7f71a13d2b38) :  DEBUG (peerservice:171) - Refreshing local server
2022-11-21 08:40:28,016 (7f71a13d2b38) :  DEBUG (peerservice:189) - Updating servers (True/False True/True/True)
2022-11-21 08:40:28,016 (7f71a13d2b38) :  DEBUG (peerservice:198) - Found 1 servers
2022-11-21 08:40:28,017 (7f71a13d2b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400'
2022-11-21 08:40:28,019 (7f71a13d2b38) :  DEBUG (core:521) - Attribute 'machineIdentifier' set to '258bf455fafeb7e411ad5fafdbda4983ea3c9ed6'
2022-11-21 08:40:28,019 (7f71a13d2b38) :  DEBUG (peerservice:230) - Creating new server JehlyFlix (258bf455fafeb7e411ad5fafdbda4983ea3c9ed6)
2022-11-21 08:40:28,019 (7f71a13d2b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/library/sections'
2022-11-21 08:40:28,022 (7f71a13d2b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/channels/all'
2022-11-21 08:40:28,023 (7f71a143bb38) :  DEBUG (peerservice:176) - Background-refreshing remote servers
2022-11-21 08:40:28,023 (7f71a143bb38) :  DEBUG (peerservice:189) - Updating servers (True/False True/True/True)
2022-11-21 08:40:28,023 (7f71a143bb38) :  DEBUG (peerservice:198) - Found 1 servers
2022-11-21 08:40:28,023 (7f71a13d2b38) :  DEBUG (runtime:1117) - Created a thread named 'background_refresh'
2022-11-21 08:40:28,024 (7f71a143bb38) :  DEBUG (peerservice:233) - Updating existing server JehlyFlix (258bf455fafeb7e411ad5fafdbda4983ea3c9ed6)
2022-11-21 08:40:28,024 (7f71a143bb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/library/sections'
2022-11-21 08:40:28,026 (7f71a143bb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/channels/all'

ChuckPa · November 21, 2022, 5:34pm

I need the ZIP file.

You cutting and posting pieces is of no help.

Jehly · November 21, 2022, 5:40pm

Sorry about that!

Plex Media Server Logs_2022-11-21_09-28-11.zip (732.9 KB)

ChuckPa · November 21, 2022, 7:45pm

Thanks for the logs.

What I see here is PMS abruptly halting.

What’s disturbing is there is no Crash Report uploading.

When there is no report uploading.

It was an orderly shutdown (which it’s not)
Crash reporting is turned off

Do you have crash reporting turned off?

IF you have crash reporting enabled then the system logs themselves are going to be needed because the reason PMS stopped didn’t make it to the PMS logs.

Jehly · November 21, 2022, 7:58pm

I’ve never asked it to disable the crash logs - How do I re-enable them?

Alaw · November 22, 2022, 8:03pm

@Jehly from the server settings, under General, there is a checkbox:

Jehly · November 22, 2022, 8:19pm

Thanks! It was NOT checked. I’ll send new logs when it crashes again. It’s been sitting at 100% for at minimum 14 hours at this point, though. Nothing being transcoded, no new media.

Jehly · November 24, 2022, 1:28pm

I believe I have narrowed it down to when the server is attempting to back itself up. I noticed it would just give a “Backing up databases” status and never complete the “circle.” When I would attempt to do it manually, it would crash the server immediately. I still don’t have much of an explanation for the CPU usage, though.

ChuckPa · November 24, 2022, 4:10pm

@Jehly

If PMS is going stupid (crashing, etc) when doing database work – the DB’s are “malformed” (damaged).

PMS can run - mostly - when they are damaged but you’ll see all kinds of weird behavior (like you’re seeing) when there is internal damage.

I wrote a repair utility for cases just like this.

There is a lot of help in the Readme.me

After you’ve read it, I recommend the option sequence 1 - 4 - 3
which is:

1 - Check (Confirm there is damage)
4 - Repair
3 - Reindex

Don’t hesitate to ask if you have questions.

Jehly · November 24, 2022, 7:06pm

I was unable to extract the .sh into the plex directory, so I ran it from the ubuntu desktop. It stated the database was “OK” and I ran a repair anyway. Same issue and it didn’t appear to work. I noticed the CPU goes to 12.5% or so usage, then I try to download the database, then it will freeze again. Ubuntu command line shows PMS running, but it wont connect, even locally.

Jehly · November 24, 2022, 7:20pm

FWIW, those are all FireSticks based on their IPs.

ChuckPa · November 24, 2022, 7:23pm

You need to be ‘root’ if you’re going to extract it in-place.

On Desktop Linux, native app installation, you can be in any directory. It will find your PMS installation.

Jehly · November 24, 2022, 7:26pm

I have Ubuntu desktop - Do I need to run it again after putting it in the plex directory? I thought I read it as you just described - It would find it on its own.

ChuckPa · November 24, 2022, 7:28pm

As the ‘root’ user (sudo bash), you run it from wherever it is.
It’s smart enough to find where PMS is installed by itself.

( you can keep it in your home/Downloads if you want. It doesn’t care)

Jehly · November 24, 2022, 7:30pm

Understood. Ran with the previously mentioned outcome - database checks OK and still hangs up when backing up database.

ChuckPa · November 24, 2022, 7:31pm

Did you perform my “Repair” function followed by “Reindex”?

ChuckPa · November 24, 2022, 7:35pm

On a completely separate note:

If you have TrueHD audio, and have problems, I recommend downgrading to 1.29.2 (Public).

There is a known, as of yet not-reproduced, problem for some users.

1.30.x contains significant internal changes. For some users, it might be more appropriate to wait a while before actually upgrading.

ChuckPa · November 24, 2022, 7:37pm

personal note: I will be AFK until later this evening

Topic		Replies	Views
Server keep "crashing" since last few beta updates Plex Media Server server-linux	113	542	March 24, 2023
PMS Keeps Crashing - Nvidia Sheild Plex Media Server server-nvidia-shield , android-tv	2	105	March 15, 2021
Random crashing of Plex Media Server suddenly after a year of stable running Plex Media Server server-windows	20	403	May 31, 2022
Plex falls alone Plex Media Server server-linux	66	1041	March 2, 2023
Plex Media Server stops manually Plex Media Server server-synology	42	437	March 5, 2026

Server pegs to 100% CPU and randomly stops running

Related topics