Plex server not being found after completing troubleshooting steps

[savantali]

Server Version#: v1.16.1.1273-4b6101f87
Player Version#: Version 3.95.2

This morning, I went to try and load up plex on my desk. Immediately, I noticed that nothing was loading and it was saying it couldn’t connect. I found this odd, and looked at the system log for the upstart service and noticed that a plugin was throwing a bunch of errors. I removed the plugin and tried to restart plex. Still had no luck.

I tried the troubleshooting steps here: https://support.plex.tv/articles/204604227-why-can-t-the-plex-app-find-or-connect-to-my-plex-media-server/

And was also forced to even log back in to plex before I had the chance to complete them. I can connect directly to the server, but I don’t see any issues as to what is preventing Plex from connecting. I have literally not changed any settings or configuration on Plex in months (plex does auto update to the beta version). So this change baffles me.

plex_not_found.log (54.1 KB)

plexmediaserver.service - Plex Media Server
Loaded: loaded (/lib/systemd/system/plexmediaserver.service; enabled; vendor preset: enabled)
Active: active (running) since Fri 2019-06-28 10:50:52 PDT; 1min 15s ago
Process: 1618 ExecStartPre=/bin/sh -c /usr/bin/test -d “${PLEX_MEDIA_SERVER_APPLICATION_SUPPORT_DIR}” || /bin/mkdir -p “${PLEX_MEDIA_SERVER_APPLICATION_SUPPORT_DIR}” (code=exited, status=0/SUCCESS)
Main PID: 1672 (sh)
Tasks: 85 (limit: 4915)
CGroup: /system.slice/plexmediaserver.service
├─1672 /bin/sh -c PLEX_MEDIA_SERVER_INFO_VENDOR=“$(grep ^NAME= /etc/os-release | awk -F= “{print $2}” | tr -d " )” PLEX_MEDIA_SERVER_INFO_DEVICE=“PC” PLEX_MEDIA_SERVER_INFO_MODEL=“$(uname -m)” PLEX_MEDIA_SERVER_INFO_PLAT
├─1823 /usr/lib/plexmediaserver/Plex Media Server
├─1911 Plex Plug-in [com.plexapp.system] /usr/lib/plexmediaserver/Resources/Plug-ins-4b6101f87/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.16.1.1273-4b6101f87 /usr/lib/plexmediaserver/
├─2719 /usr/lib/plexmediaserver/Plex DLNA Server
├─2729 /usr/lib/plexmediaserver/Plex Tuner Service /usr/lib/plexmediaserver/Resources/Tuner/Private /usr/lib/plexmediaserver/Resources/Tuner/Shared 1.16.1.1273-4b6101f87 32600 /waitmutex
└─3073 Plex Plug-in [com.plexapp.agents.imdb] /usr/lib/plexmediaserver/Resources/Plug-ins-4b6101f87/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.16.1.1273-4b6101f87 /usr/lib/plexmediase

Jun 28 10:50:52 plex systemd[1]: Starting Plex Media Server…
Jun 28 10:50:52 plex systemd[1]: Started Plex Media Server.

[ChuckPa]

Some basic info please?

1. Is the server local or remote?
2. If local, are you and it on the same subnet?
3. Also if local, RFC-1918 compliant “Private Network” (10.x.x.x, 172.16.x.x - 172.31.x.x, and 192.168.x.x)

Have you attempted to:

1. Different browser
2. Signed out of your plex account
3. Open an incognito window in that browser
4. Opened http://ip.addr.of.host:32400/web directly? (I presume you have if the plex/web loads)

All this not-withstanding;

Create a tarball.gz (as root) of “/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Logs” and atttach here please.

[savantali]

1. Local
2. Same subnet
3. Yes, 192.168.X network

I have tried two different devices, two different browsers on the same machine

Logs.tar (8.0 MB)

[ChuckPa]

You have a domain cert involved.

Jun 28, 2019 10:51:36.493 [0x7f0865bd9700] ERROR - SSDP: Error parsing device schema for http://192.168.2.9:8080/upnp
Jun 28, 2019 10:51:47.964 [0x7f0875be7700] DEBUG - Request came in with unrecognized domain / IP 'plex.localnet' in header Host; treating as non-local
Jun 28, 2019 10:51:47.964 [0x7f084a7fc700] DEBUG - Request: [192.168.2.30:59961 (Subnet)] GET /web/index.html (7 live) GZIP

Given PMS doesn’t know about this domain yet, it will conflict. (you add the domain cert after setup in Settings - Server - Network)

SSH tunnel to it will work in this case

ssh -L 8888.127.0.0.0.1:32400  ip.addr.of.host
sign in
let that session sit idle

in local browser: http://127.0.0.1:8888/web

Now it will behave as if you are on the machine’s loopback adapter / console.

[ChuckPa]

As supplemental information, I would recommend using one of the more standard domain suffixes. .LAN and .LOCAL are two better choices.

[savantali]

So doing that allowed me to access the plex server.

However, I am now confused as to why it seemingly lost any connection/it’s UUID. This seems like abnormal behavior - especially if the server didn’t experience any MAJOR changes (beyond upgrading the plex software). Or why restarting the host might have caused this issue.

[ChuckPa]

The UUID / Processed machine ID was most likely still in the Preferences.xml however if it becomes signed-out for whatever reason, it will require this more secure authentication to ensure it’s really you coming back to attach it to your ccount.

[savantali]

But if it is now showing two instances with the same name (I don’t have any other plex server named plex besides this one), wouldn’t that indicate a UUID change or some other change?

[ChuckPa]

I looked at the Plex.tv record for your account.
It shows the original instance was last seen about a day ago and the updated UUID about 10 minutes ago.

The only way the UUID can change is if Preferences.xml was removed or the UUID itself was removed from the file.

Now that you’re signed in, you can go to Settings - Devices - Servers and remove the previous.

[savantali]

To my knowledge (this is not a managed endpoint), that should not have been the case. If I run stat on the command (unfortunately I cat’ed the file) it shows the last time I cat’ed the file:

plex:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server$ stat Preferences.xml
File: Preferences.xml
Size: 764 Blocks: 8 IO Block: 4096 regular file
Device: fd00h/64768d Inode: 654507 Links: 1
Access: (0600/-rw-------) Uid: ( 111/ plex) Gid: ( 118/ plex)
Access: 2019-06-28 12:51:27.730943565 -0700
Modify: 2019-06-28 12:50:59.926772313 -0700
Change: 2019-06-28 12:50:59.926772313 -0700
Birth: -

But I can tell with 100% certainty that I did not make a chang eto this file over the past 48 hours.

[ChuckPa]

stat won’t tell us at this point. if you stat . it should also show the same.

If true, then something happened to the file outside of Plex’s realm.
Do you have audit logs?

[savantali]

I unfortunately don’t have audit logs (or at least I don’t enable them), and if I did - not sure where I would find them in Ubuntu.

[ChuckPa]

They would be under /var/log/audit but it would be messy at that level. Tracking each file would be significan’t load.

As an alternative, you can look at the systemd logs and see when PMS was previously stopped and restarted just before this issue occurred

[savantali]

So unfortunately, that log file is too large to figure that, there were a lot of plugin errors, and I don’t see anywhere it restarted the service on it’s own (besides my restarting the host).

So I can’t give anymore information.

[ChuckPa]

Please do your best to keep an eye on when it acts strangely again.

If your logs are getting big and not rotating, this indicates a problem with auditd itself.

my logs are much quieter and this is a development system.

sudo ls -la /var/log/audit
total 16820
drwx------.  2 root root      61 Jun 25 16:42 .
drwxr-xr-x. 22 root root    4096 Jun 23 03:43 ..
-rw-------   1 root root  429177 Jun 28 16:30 audit.log
-r--------   1 root root 8388766 Jun 25 16:42 audit.log.1
-r--------.  1 root root 8388621 Jan 29 01:35 audit.log.2
[chuck@lizum Plex Media Server.221]$ ```

[savantali]

This happened again today.

It occurred after my disk space was full with ~70 MB left. I did not touch the Plex folder except for removing a bundle again.

I still don’t have auditd enabled apparently however running Stat on preferences.xml again results in this:

stat Preferences.xml
  File: Preferences.xml
  Size: 310             Blocks: 8          IO Block: 4096   regular file
Device: fd00h/64768d    Inode: 663418      Links: 1
Access: (0600/-rw-------)  Uid: (  111/    plex)   Gid: (  118/    plex)
Access: 2019-08-13 19:33:30.788600072 -0700
Modify: 2019-08-13 19:33:25.740600015 -0700
Change: 2019-08-13 19:33:25.740600015 -0700
 Birth: -

@plex:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server$ ls -al
total 56
drwxr-xr-x 12 plex plex 4096 Aug 13 20:05  .
drwxr-xr-x  3 plex plex 4096 Feb  4  2018  ..
drwxr-xr-x  6 plex plex 4096 Aug 13 20:04  Cache
drwxr-xr-x 11 plex plex 4096 Jul 26 01:16  Codecs
drwxr-xr-x 43 plex plex 4096 Jul 25 06:25 'Crash Reports'
drwxr-xr-x  2 plex plex 4096 May 10  2018  Diagnostics
drwxr-xr-x  3 plex plex 4096 Aug 13 20:04  Logs
drwxr-xr-x  3 plex plex 4096 Feb  4  2018  Media
drwxr-xr-x  6 plex plex 4096 Mar 11 10:06  Metadata
-rw-r--r--  1 plex plex    4 Aug 13 20:04  plexmediaserver.pid
drwxr-xr-x  6 plex plex 4096 Aug 13 20:01  Plug-ins
drwxr-xr-x  8 plex plex 4096 Apr 20 19:39 'Plug-in Support'
-rw-------  1 plex plex  654 Aug 13 20:05  Preferences.xml
drwxr-xr-x  3 plex plex 4096 Apr 23 18:06  Thumbnails

I have not touched the file in the past hour.

I also noticed that my folder for Plex is roughly ~24 GB, not sure if that is relevant or usual.

I have just installed auditd on my device. @ChuckPa would you mind providing any rules that you have for Plex so I can track this, as this is the second occurrence in two months.

The only thing I can think of is that it is possibly this is the plex auto updater tool (https://github.com/mrworf/plexupdate) as I did have a plex update this week showing as available. When logging in directly to the server, I can see that an update is still available.

This is quite annoying though - as this means that I need to setup my client again for the home screen on Android TV and on my Plex UI page.

[ChuckPa]

Given the apparent very small size of your root partition, I would like you to consider two steps.

1. Move the metadata first and foremost to keep you running.
2. Verify this is the root cause

The sequence of steps uses systemd standard techniques. Please let me know if you need help with this.

Moving PMS 'Library'

Moving Plex’s metadata (Library) directory on systemd based systems This information is intended for those systems where cat /proc/1/comm returns systemd. If your system returns init, please see the next post in this thread. While you may change /lib/systemd/system/plexmediaserver.service, it is under the control of the package manager and subject to replacement without warning at any time during an update. To provide stability, systemd allows creation of an override.conf file to customiz…

[savantali]

Unfortunately, it isn’t that the root partition is small, it’s just that a few logs don’t rotate & the GDrive Cache that I am using fills up a lot. ( In the mean time I have lowered the logging level of some of the log files, and lowered the cache purge value as well to three days instead of one week which is what it was previously).

/dev/mapper/plex–vg-root 112G 27G 80G 26% /

I don’t have a spare drive to attach to that ( at least not the time to do this for another three weeks).

Will give it a go after September.

[savantali]

So after going on vacation, and coming back - I believe this has happened a few times on vacation (as I noticed that there seemed to be a few more servers listed).

When looking at the audit.log file (grepped for plex) I see the following:

type=SERVICE_START msg=audit(1565789142.748:2525): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_STOP msg=audit(1565789142.748:2526): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1565789149.648:2536): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1565843084.252:5555): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_STOP msg=audit(1565843084.252:5556): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1565843108.909:49): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1566307536.825:6688): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_STOP msg=audit(1566307536.825:6689): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1566307544.093:6700): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_STOP msg=audit(1566825936.152:13432): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
type=SERVICE_START msg=audit(1566825943.332:13443): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=plexmediaserver comm="systemd" exe="/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'

Unfortunately, the syslog files have rotated already so I cannot see exactly what happened during those times.

[savantali]

This might be a secondary issue but I am also seeing this occur:

andrew@plex:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Logs$ sudo cat ../../Plex\ Media\ Server/Preferences.xml
[sudo] password for andrew:
<?xml version="1.0" encoding="utf-8"?>
<Preferences OldestPreviousVersion="1.16.3.1402-22929c8a2" MachineIdentifier="OMIT" ProcessedMachineIdentifier="OMIT" AnonymousMachineIdentifier="OMIT" MetricsEpoch="1" AcceptedEULA="1" PublishServerOnPlexOnlineKey="1" PlexOnlineToken="OMIT" PlexOnlineUsername="OMIT" PlexOnlineMail="OMIT" LastAutomaticMappedPort="28204" CertificateUUID="OMIT" CertificateVersion="2" PubSubServer="184.105.148.115" PubSubServerRegion="sjc" PubSubServerPing="29" LanguageInCloud="1" CloudSyncNeedsUpdate="0" FSEventLibraryPartialScanEnabled="1" FSEventLibraryUpdatesEnabled="1" ScheduledLibraryUpdatesEnabled="1" ButlerUpdateChannel="0"/>
andrew@plex:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Logs$ tail -f  Plex\ Media\ Server.log
Sep 11, 2019 15:04:28.674 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 118 seconds for it to complete.
Sep 11, 2019 15:04:30.348 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 117 seconds for it to complete.
Sep 11, 2019 15:04:31.696 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 116 seconds for it to complete.
Sep 11, 2019 15:04:32.011 [0x7f736bfff700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:32.011 [0x7f7370fab700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:32.016 [0x7f736bfff700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:32.022 [0x7f7370fab700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:33.393 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 115 seconds for it to complete.
Sep 11, 2019 15:04:33.852 [0x7f7370fab700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:34.786 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 114 seconds for it to complete.
Sep 11, 2019 15:04:36.572 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 113 seconds for it to complete.
Sep 11, 2019 15:04:38.144 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 112 seconds for it to complete.
Sep 11, 2019 15:04:39.288 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 111 seconds for it to complete.
Sep 11, 2019 15:04:40.107 [0x7f736bfff700] DEBUG - WebSocket: client initiated close
Sep 11, 2019 15:04:40.107 [0x7f736bfff700] DEBUG - NotificationStream: Removing because of close
Sep 11, 2019 15:04:40.108 [0x7f7370fab700] DEBUG - handleStreamRead code 335544539: short read
Sep 11, 2019 15:04:40.576 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 110 seconds for it to complete.
Sep 11, 2019 15:04:41.155 [0x7f736bfff700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:42.152 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 109 seconds for it to complete.
Sep 11, 2019 15:04:43.305 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 108 seconds for it to complete.
Sep 11, 2019 15:04:44.120 [0x7f734d7fa700] DEBUG - NetworkServiceBrowser: Parsing SSDP schema for http://192.168.2.9:8080/upnp
Sep 11, 2019 15:04:44.120 [0x7f734d7fa700] DEBUG - HTTP requesting GET http://192.168.2.9:8080/upnp
Sep 11, 2019 15:04:44.120 [0x7f734d7fa700] DEBUG - HTTP 404 response from GET http://192.168.2.9:8080/upnp
Sep 11, 2019 15:04:44.120 [0x7f734d7fa700] ERROR - SSDP: Error parsing device schema for http://192.168.2.9:8080/upnp
Sep 11, 2019 15:04:44.610 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 107 seconds for it to complete.
Sep 11, 2019 15:04:46.220 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 106 seconds for it to complete.
Sep 11, 2019 15:04:47.349 [0x7f728bfe7700] ERROR - Error issuing curl_easy_perform(handle): 28
Sep 11, 2019 15:04:47.349 [0x7f728bfe7700] DEBUG - HTTP simulating 408 after curl timeout
Sep 11, 2019 15:04:47.350 [0x7f728bfe7700] ERROR - Error parsing content.
Sep 11, 2019 15:04:47.350 [0x7f728bfe7700] ERROR - Error parsing XML response for update.
Sep 11, 2019 15:04:47.351 [0x7f727dfcb700] DEBUG - Media Analyzer: Performing on-the-fly analysis on 1 item.
Sep 11, 2019 15:04:47.351 [0x7f727dfcb700] DEBUG - Job running: '/usr/lib/plexmediaserver/Plex Media Scanner' '--analyze' '--log-file-suffix' ' Analysis' '--item' '33168'
Sep 11, 2019 15:04:47.351 [0x7f727dfcb700] DEBUG - Jobs: Starting child process with pid 17090
Sep 11, 2019 15:04:47.440 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 105 seconds for it to complete.
Sep 11, 2019 15:04:48.113 [0x7f7370fab700] DEBUG - EventSource: Got event [data] '<Message address="24.7.56.27" port="28204" connectivity="0" command="notifyConnectivity"/>'
Sep 11, 2019 15:04:48.117 [0x7f7370fab700] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (, expected a484c7d4-83d2-4de7-88ac-5cedd3cb9c00)
Sep 11, 2019 15:04:48.880 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 104 seconds for it to complete.
Sep 11, 2019 15:04:48.890 [0x7f7370fab700] DEBUG - Auth: authenticated user 1 as savantali
Sep 11, 2019 15:04:50.760 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 103 seconds for it to complete.
Sep 11, 2019 15:04:51.566 [0x7f736bfff700] DEBUG - EventSource: Got event [data] '<Message host="184.105.148.89" port="443" command="startRelay"/>'
Sep 11, 2019 15:04:51.566 [0x7f736bfff700] DEBUG - HTTP requesting GET https://downloads.plex.tv/relay/relay_v1.pub
Sep 11, 2019 15:04:51.745 [0x7f736bfff700] DEBUG - HTTP 200 response from GET https://downloads.plex.tv/relay/relay_v1.pub
Sep 11, 2019 15:04:51.745 [0x7f736bfff700] DEBUG - Relay: refreshed host key from https://downloads.plex.tv/relay/relay_v1.pub
Sep 11, 2019 15:04:51.746 [0x7f736bfff700] DEBUG - Relay: starting relay.
Sep 11, 2019 15:04:51.746 [0x7f736bfff700] DEBUG - Job running: PLEXTOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Relay' '-p' '443' '-N' '-R' '0:127.0.0.1:32401' '-o' 'StrictHostKeyChecking=yes' '-o' 'UserKnownHostsFile=/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/relayHostKey.txt' '-o' 'NoneSwitch=yes' '-o' 'NoneEnabled=yes' '-o' 'LogLevel=VERBOSE' '-o' 'PreferredAuthentications=password' '-o' 'PubkeyAuthentication=no' '-l' 'savantali' '-F' '/dev/null' '184.105.148.89'
Sep 11, 2019 15:04:51.748 [0x7f736bfff700] DEBUG - Jobs: Starting child process with pid 17096
Sep 11, 2019 15:04:52.521 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 102 seconds for it to complete.
Sep 11, 2019 15:04:52.748 [0x7f7371fad700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 17090 is 0 (success)
Sep 11, 2019 15:04:52.748 [0x7f727dfcb700] DEBUG - Killing job.
Sep 11, 2019 15:04:52.748 [0x7f727dfcb700] DEBUG - Signalling job ID 17090 with 9
Sep 11, 2019 15:04:52.748 [0x7f727dfcb700] DEBUG - Media Analyzer: Background analysis completed in 5.4 seconds, removing 1 IDs
Sep 11, 2019 15:04:52.753 [0x7f728bfe7700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Sep 11, 2019 15:04:52.753 [0x7f728bfe7700] DEBUG - Selecting best audio stream for part ID 36684 (autoselect: 1 language: en)
Sep 11, 2019 15:04:52.753 [0x7f728bfe7700] DEBUG - We're going to try to auto-select a subtitle.
Sep 11, 2019 15:04:52.753 [0x7f728bfe7700] DEBUG - Audio Stream: 145227, Subtitle Stream: -1
Sep 11, 2019 15:04:52.754 [0x7f728bfe7700] DEBUG - Request: [172.17.0.2:58726 (WAN)] GET /library/metadata/33168 (82 live) TLS Signed-in Token (savantali)
Sep 11, 2019 15:04:52.758 [0x7f736bfff700] DEBUG - Completed: [172.17.0.2:58714] 200 GET /library/metadata/33168 (82 live) TLS 109102ms 2339 bytes (pipelined: 1)
Sep 11, 2019 15:04:52.759 [0x7f728bfe7700] DEBUG - Last refresh (1900-01-01 00:00:00) appears to be older than directory change time (2019-09-11 14:14:00), need to refresh local media agent.
Sep 11, 2019 15:04:52.760 [0x7f728bfe7700] DEBUG - Refreshing GUID: 'local://33168'
Sep 11, 2019 15:04:52.760 [0x7f728bfe7700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/update?mediaType=4&force=1&parentGUID=local%3A%2F%2F33158&parentID=33158&guid=local%3A%2F%2F33168&id=33168&agent=com.plexapp.agents.localmedia&async=0
Sep 11, 2019 15:04:54.042 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 101 seconds for it to complete.
Sep 11, 2019 15:04:55.084 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 100 seconds for it to complete.
Sep 11, 2019 15:04:56.168 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 99 seconds for it to complete.
Sep 11, 2019 15:04:57.336 [0x7f72897e2700] DEBUG - [com.plexapp.agents.localmedia] Plug-in is starting, waiting 98 seconds for it to complete.

In this case, I am accessing the server remotely, but, it was playing an episode of Dave Chappelle for ~1.5 hours, and then the video just abruptly halted and stopped playing. Then the above errors started occurring from the agents.localmedia plug-in.

If I go into a library, it asks me to attempt with an insecure connection, and if I hit Allow Once, it attempts to connect and fails.

If I try to do it locally or remotely, using plex.tv or the host’s local domain (plex.localnet) it fails to load anything.

Once I restart the service, it works fine.