Can't reach PMS on Synology 916+

Synology 916+, runing DSM 6.2.2-24922 Update 3 (haven’t downloaded Update 4 yet).

I’ve been running PMS on my Synology for a couple years. Tonight, I came home, and the PMS server there couldn’t be contacted, according to the Plex Media Player on my Win 10 PC. I tried stopping and starting Plex on the NAS, to no effect. I tried signing in and out of my account at plex.tv; no effect. I tried using the web interface (http://:32400/web). The web interface just times out. Tried with an incognito window in Chrome; no difference, still times out.

I can SSH into the NAS. It seems the PMS is running:

turgon@Warehouse-1:/$ ps -ef | grep plex
turgon 1986 21717 0 18:31 pts/15 00:00:00 grep --color=auto plex
plex 7061 1 1 Oct14 ? 10:18:37 /var/packages/Plex Media Server/target/Plex Media Server
plex 30651 7061 0 Oct23 ? 00:00:11 Plex EAE Service

Plex user is in group users and video, and has R/W perms to all the shares, and custom perms to the Plex share itself. I haven’t touched anything here at all …

The NAS itself seems to be running fine, I am accessing the file shares on Windows just fine. Other apps are running on the NAS - Sonarr, Radarr - they are accessible and working. It’s only Plex …

I’d attach logs, but I can’t get to an interface for the server at all. :slight_smile:PMS version is 1.18.0.1944-f2cae8d6b., according to my list of Authorized Devices.

I can’t restart the NAS, it is providing shares for other things.

Thoughts? Next steps?

Drill into Plex share in FileStation

Make a ZIP file of the Logs directory (Compress to ZIP from the right mouse click)

Attacj that Zip

Having same issue with my 918+. Same versions. I just updated plex to latest on the plex.tv site as it was newer than the version I had on the synology. PlexMediaServer-1.18.2.2029-36236cc4c-x86_64

i’m trying to figure out how to get the logs.

I am able to telnet to the 32400 port and connect. Just nothing happens.

~ $ telnet hoth 32400

Trying 172.31.100.7…

Connected to 172.31.100.7

Escape character is ‘^]’.

^]

telnet> quit

Connection closed.

(Edit: Clarity)

So figured out how to get to the logs. Seems I started getting some 500 internal errors a few hours ago. Looks like my internet dropped but is back at this time. However the logs are filled from this start time (1657) to current

Nov 13, 2019 16:57:31.352 [0x7f86cd3f5700] DEBUG - Shutting down with signal 15 (Terminated)
Nov 13, 2019 16:57:31.352 [0x7f86cd3f5700] DEBUG - Ordered to stop server.
Nov 13, 2019 16:57:31.352 [0x7f86cd3f5700] WARN - Timed out waiting for server to finish.
Nov 13, 2019 16:57:31.353 [0x7f86d7d8f740] DEBUG - Stopping server...
Nov 13, 2019 16:57:31.353 [0x7f86d7d8f740] DEBUG - HttpServer: Stopping server.
Nov 13, 2019 16:57:32.353 [0x7f86d7d8f740] WARN - Timed out waiting for server to finish.
Nov 13, 2019 16:57:32.354 [0x7f86d7d8f740] DEBUG - Server stopped.
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - NetworkService: Stopping advertisement.
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - Killing plug-ins.
Nov 13, 2019 16:57:32.366 [0x7f86be09b700] ERROR - Network Service: Error in advertiser handle read: 125 (Operation canceled) sock
et=72
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - [org.musicbrainz.agents.music] Killing.
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - [tv.plex.agents.music] Killing.
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - [com.plexapp.system] Killing.
Nov 13, 2019 16:57:32.366 [0x7f86d7d8f740] DEBUG - Waiting for Plex Tuner Service to exit.
Nov 13, 2019 16:57:32.371 [0x7f86cd3f5700] WARN - JobManager: Could not find job for handle 11877
Nov 13, 2019 16:57:32.373 [0x7f86cd3f5700] WARN - JobManager: Could not find job for handle 11874
Nov 13, 2019 16:57:32.376 [0x7f86cd3f5700] WARN - JobManager: Could not find job for handle 10340
Nov 13, 2019 16:57:32.466 [0x7f86be09b700] INFO - Network Service: Abandoning advertise socket, it was closed.
Nov 13, 2019 16:57:32.655 [0x7f86cd3f5700] DEBUG - Jobs: '/volume1/@appstore/Plex Media Server/Plex Tuner Service' exit code for p
rocess 10783 is 0 (success)
Nov 13, 2019 16:57:32.656 [0x7f86bddad700] DEBUG - Plex Tuner Service exited.
Nov 13, 2019 16:57:39.048 [0x7f86662b3700] DEBUG - Stopping file watcher for tv.plex.agents.music
Nov 13, 2019 16:57:39.781 [0x7f86be965700] DEBUG - Stopping file watcher for com.plexapp.system
Nov 13, 2019 16:57:41.199 [0x7f8665cd7700] DEBUG - Stopping file watcher for org.musicbrainz.agents.music
Nov 13, 2019 16:59:49.270 [0x7f86cd3f5700] DEBUG - Server is already in shutdown mode, ignoring this signal...
Nov 13, 2019 16:59:49.873 [0x7f86bf22f700] DEBUG - File "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-c186313fe" change
d: 2019-11-11 07:36:40 (1573483000) => 2019-11-13 16:59:49 (1573689589).
Nov 13, 2019 16:59:50.873 [0x7f86bf22f700] DEBUG - Scanning for plug-ins in "/volume1/@appstore/Plex Media Server/Resources/Plug-i
ns-c186313fe"
Nov 13, 2019 16:59:50.873 [0x7f86bf22f700] DEBUG - Scanning for plug-ins in "/volume1/Plex/Library/Application Support/Plex Media 
Server/Plug-ins"
Nov 13, 2019 16:59:50.905 [0x7f86bf22f700] DEBUG - PluginRepository::setStartState: 1, startingSystem
Nov 13, 2019 16:59:52.946 [0x7f86bf22f700] WARN - Warning: ex: boost::filesystem::last_write_time: No such file or directory: "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-c186313fe", couldn't check file: "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-c186313fe"

<SNIP>

Nov 13, 2019 17:28:55.198 [0x7f86bf22f700] WARN - Warning: ex: boost::filesystem::last_write_time: No such file or directory: "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-c186313fe", couldn't check file: "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-c186313fe"

One thing I noticed on the log messages is that it’s complaining on that plugin thing… which is the same number as the version of PMS I installed yesterday afternoon . (c186313fe)

PlexMediaServer-1.18.1.2019-c186313fe-x86_64.spk . <<<< lastnight installed

PlexMediaServer-1.18.2.2029-36236cc4c-x86_64.spk . <<<< today installed

But we watched videos lastnight with out issues. So this all started later on and noticed today after we came home from work.

I had to give my account access to that folder in Control Panel (it had no access). Logs attached.

Logs.zip (5.3 MB)

I just had the same issue on a DS918+, it was working fine yesterday, and tonight I couldn’t reach the server with the web UI or with a client. Strangely enough, when I tried restarting the service in the Package Center, the logs didn’t update – they were just stuck on older messages.

When I had a look at the running processes, I noticed that even when the service was stopped, there was a couple of Plex plugin container processes still running (namely Trakt and SubZero). I could have tried killing those but I opted for a simple solution and just rebooted the NAS. That fixed it so far and I can access Plex again.

My guess is that there’s a new bug introduced in PlexMediaServer-1.18.1.2019-c186313fe that makes plugin processes mess up with the server somehow.

I’m having the same issues even though I haven’t updated plex for 3 weeks. How can this happen?

I didn’t logon to the CLI of the Synology to check for those processes… but I did reboot it and now I can access the web gui from my browser. My AppleTV client can reach the server as well.

Not 100% if the issue is because I dropped internet yesterday afternoon for about 30 min and things got wigged out.

Restart DSM?

We need to figure out if this is between DSM - internet or PMS - DSM


ChuckPA

      Team Member




    November 14

Restart DSM?

We need to figure out if this is between DSM - internet or PMS - DSM

Well, since I haven’t installed Update 4, and that requires a restart, I am going to install the Update tonight, and restart, see if it helps.

I’m with you, that seems like just chance that it resolves the issue, but I doubt it could hurt the current situation.

I’ve got 3 Syno systems here and can’t reproduce it yet.
This is why I’m more open to being inventive about investigating.

I’m starting to suspect the Windows box.
I am entirely Linux but do have a pristine Windows VM.
All of that also works flawless.

That is a good question. I just restarted DSM as I saw it worked for someone else. But I didn’t install Update 4. Didn’t want to add another variable to it.

But once DSM came back up Plex was available and working with out issues. So far it’s still working. But haven’t lost my connection home from work today like I did yesterday.

The logs i found did say PMS was having issues reaching sites. I will see if I can get the logs again when I get home.
On a side note… I’m using an Apple TV for client and my Mac for web gui primarily. I do have a windows VM that is working now too.

Well, I can’t connect to the Synology Plex using 2 different Windows 10 PCs, nor my Samsung TV, nor my Amazon FireTV Stick, nor my Roku. :slight_smile:

So in my case, I don’t think the client has anything to do with it.

@MikeLeone

Let me ask the very basics (Which I request of everyone joining in)

  1. LAN IP of the server and of at least one of the accessing devices ?
  2. VPN in use?

On the Synology:

  1. What is the default gateway adapter?
  2. Does the Synology DNS point to the gateway (the modem router) or elsewhere?
  3. Has the MTU parameter of the ethernet adapter been changed from the default of 1500 ?
  4. Is anything in a Docker container or VM ?

ChuckPA Team Member
November 14

@MikeLeone

Let me ask the very basics (Which I request of everyone joining in)

LAN IP of the server and of at least one of the accessing devices ?
VPN in use?

No VPN, this is all local, on the same LAN. I use 10.0.0.x for all my devices.

On the Synology:

What is the default gateway adapter?
Does the Synology DNS point to the gateway (the modem router) or elsewhere?
Has the MTU parameter of the ethernet adapter been changed from the default of 1500 ?
Is anything in a Docker container or VM ?

No VM, no Docker. No changes to network configuration (static IPs
only, for me). The Synology has no communication problems with other
services that communicate over HTTP (i.e., Sonarr, Radarr), so it
can’t be the default gateway of the NAS, else nothing would
communicate via web interface. It’s only Plex that is problematic and
unresponsive.

mike,

  1. Do you have “Partial Scan” of your media enabled? It’s scanning the whole library.
    Or did you just add a lot of media?

Settings - Server - Library - Show Advanced

  1. It’s generating a lot of thumbnails (VERY hard on that little Synology CPU).

It’s no wonder it’s not very responsive.
If you don’t use chapter thumbnails when playing (seeking to chapters), I’d recommend saving yourself a lot of time & headache by disabling them (they are on by default).

  1. By overall look of the logs, it’s not done with the first tasking when it starts over. We can take care of this in the settings (Partial Scan & Automatically Detect options)


ChuckPA

      Team Member




    November 14

mike,

  1. Do you have “Partial Scan” of your media enabled? It’s scanning the whole library.

No.

  1. Or did you just add a lot of media?

I removed a lot of media …

Settings - Server - Library - Show Advanced

  1. It’s generating a lot of thumbnails (VERY hard on that little Synology CPU).

Since I can’t access my server at all, I can’t see those settings.

Let’s take this down to hard basics:

  1. Get firefox if you don’t have it
  2. Open up an incognito window
  3. Disable all the plug-ins (while in that window)
  4. Pull the XML only from your Plex server with http://ip.addr.of.syno:32400/ (notice no /web URL).
    a. It will respond with a goofy looking XML document or unauthorized error.
    b. If it responds with XML, let me see the first 3 XML lines only (keep the rest private)

Please advise of result. Results will determine if beer can opener or sledgehammer is needed.

I restarted my DS916+ (didn’t install the DSM update), and it’s all back fine now.

So, for me, the restart fixed it all. Odd. You might think it was Windows. LOL

So I’m all good, for the moment. In fact, I started a library scan (I don’t do partial scans, but I do have it set to scan periodically). And the scan is finding items downloaded last night.

Thanks for all the help.

I urge you to consider changing your scanning policy.

  1. Saves CPU
  2. Adding / removing media is much more responsive (it will only scan what has changed and not re-scan everything).