Why does Plex Media Server for my Synology DS 916+ keeps disconnected and not able to find the server?
This happens after I’ve updated to the latest Plex Media Server for Synology.
I have to keep restarting my DS916+ then Plex will work. But after awhile, Plex can’t find my server again.
I’ve tried deleting the Preferences file but it’s still not working. This is reall fustrating…
I never had such issues before…
Someone please help…
Plex share.Logs
Compress to Logs.zipI have attached the Logs. Can you check and let me know why is it disconnecting often?
Would you please turn Verbose logging back off and recreate ? It generates too much information for the default buffer to hold. I was almost there and what I needed to see had rolled off. (See blue sticky to the right -->) 
It has always been off before I created the zip file. I just checked and it shows “Disabled”.
Edit: Sorry. I’ve found the checkbox on Verbose. I’ve deleted all my logs, start fresh install and unchecked Verbose. Attached is my log file. If it don’t show what was happening, then I’ll wait till the server can’t be found issue and post it back here.
Do let me know if the attached log file helps.
A. It’s still verbose.
Dec 27, 2017 18:37:54.326 [0x7f23e8911700] VERBOSE - WebSocket: processed 1 frame(s)
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] DEBUG - Request: [43.249.39.230:3317 (WAN)] OPTIONS /:/prefs?LogVerbose=0 (6 live) TLS GZIP Signed-in Token ()
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Host => 42-60-68-97.d7a2a91fe61543e5a5acb1e46ec27ef7.plex.direct:25145
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * User-Agent => Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:57.0) Gecko/20100101 Firefox/57.0
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Accept => text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Accept-Language => en-US,en;q=0.5
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Accept-Encoding => gzip, deflate, br
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Access-Control-Request-Method => PUT
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * Origin => http://lins.rocks:32400
Dec 27, 2017 18:38:01.386 [0x7f23e1fff700] VERBOSE - * DNT => 1
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * Connection => keep-alive
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Client-Identifier => k7r6w349188umitsj4ryf4h2
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Device => Windows
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Device-Name => Plex Web (Firefox)
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Device-Screen-Resolution => 1920x947,1920x1080
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Platform => Firefox
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Platform-Version => 57.0
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Product => Plex Web
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Provider-Version => 1.1
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Sync-Version => 2
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Version => 3.31.1
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * LogVerbose => 0
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Product => Plex Web
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Version => 3.31.1
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Client-Identifier => k7r6w349188umitsj4ryf4h2
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Platform => Firefox
Dec 27, 2017 18:38:01.387 [0x7f23e1fff700] VERBOSE - * X-Plex-Platform-Version => 57.0
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Sync-Version => 2
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Device => Windows
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Device-Name => Plex Web (Firefox)
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Device-Screen-Resolution => 1920x947,1920x1080
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Dec 27, 2017 18:38:01.388 [0x7f23e1fff700] VERBOSE - * X-Plex-Provider-Version => 1.1
Dec 27, 2017 18:38:01.389 [0x7f23e8911700] DEBUG - Completed: [43.249.39.230:3317] 200 OPTIONS /:/prefs?LogVerbose=0 (6 live) TLS GZIP 3ms 349 bytes (pipelined: 10)
Dec 27, 2017 18:38:01.478 [0x7f23e8bff700] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Dec 27, 2017 18:38:01.478 [0x7f23e8bff700] DEBUG - Auth: authenticated user 1 as damianlin
B. I only get a partial log set… I see it’s manually captured. Can you capture the full set, without deleting anything before, via Settings - Server - Help - Download Logs
Please see attached. Not sure if verbose is still in there. If so can you let me know the steps to disable it properly?
Thanks… That got it.
Now I can see what’s happening as you’re playing.
I see the iPad playing. I next see it commanded to stop because the connection is lost (error 104 below). Since it’s an iPad, the most likely cause is a jammed full (busy) wifi or signal is too weak and the iPad has to hunt for a new radio channel. When it switches, playback will be interrupted.
Dec 28, 2017 02:58:35.984 [0x7f23e7fff700] DEBUG - Streaming Resource: Terminated session 0x7f23e519f420:234E9512-F194-4491-BC08-60E38D4E52A8 with reason Client stopped playback.
Dec 28, 2017 02:58:35.984 [0x7f23e7fff700] DEBUG - Streaming Resource: Removing session 0x7f23e519f420:234E9512-F194-4491-BC08-60E38D4E52A8
Dec 28, 2017 02:58:35.984 [0x7f23d9e43700] DEBUG - Killing job.
Dec 28, 2017 02:58:35.984 [0x7f23d9e43700] DEBUG - Signalling job ID 6376 with 9
Dec 28, 2017 02:58:35.984 [0x7f23d9e43700] DEBUG - Job was already killed, not killing again.
Dec 28, 2017 02:58:35.984 [0x7f23d9e43700] DEBUG - Stopping transcode session E0B28E36-90B0-4BF2-82FE-166EC14623E4
Dec 28, 2017 02:58:35.984 [0x7f23d9e43700] DEBUG - Cleaning directory for session E0B28E36-90B0-4BF2-82FE-166EC14623E4 (/volume1/Plex/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-E0B28E36-90B0-4BF2-82FE-166EC14623E4-0a0d6916-09fd-42f6-9798-e7fbcb9742a2)
Dec 28, 2017 02:58:36.016 [0x7f23e8911700] DEBUG - Failed to stream media, client probably disconnected: 104 - Connection reset by peer
Dec 28, 2017 02:58:36.016 [0x7f23e8911700] DEBUG - Completed: [127.0.0.1:38156] 200 GET /library/parts/101862/1513519142/file.mp4 (6 live) 424430ms 61666704 bytes
Dec 28, 2017 02:58:36.018 [0x7f23e5bff700] DEBUG - JobManager: child process killed by signal: 9 (Killed)
Dec 28, 2017 02:58:36.018 [0x7f23e5bff700] DEBUG - Jobs: '/volume1/@appstore/Plex Media Server/Plex Transcoder' exit code for process 6376 is -9
Dec 28, 2017 02:58:36.157 [0x7f23d9e43700] DEBUG - Transcoder: Cleaning old transcode directories.
How far from the Wifi ? 2.4 or 5 Ghz? B? G? N? AC?
The problem is not about the iPad. It’s about the media server keep disconnecting itself.
Any device also can’t detect it when that happens. I’ve tried tvOS, Windows Plex and all are not detecting it when it suddenly disconnected from Synology. Synology internet connection is working thou. Plex media server is intermittent on staying online.
But are you saying the iPad is causing the media server to be disconnected from my Synology?
Maybe I’m not understanding what you mean by Why does Plex Media Server for my Synology DS 916+ keeps disconnected and not able to find the server?
PMS is running on your Synology. What does your Synology disconnect from? Itself? Your LAN? This is the piece I’m not understanding.
The Synology is always connected via LAN and it’s online.
PMS previously was connected and online. But sometimes it suddenly goes offline when Synology have no issue with its connection.
There are times when my friends or I wanted to watch something from my PMS but it shows searching for server and end up the server is not found.
I always need to restart my Synology in order for PMS to be online again and to be detected by all the Plex apps or programs.
Thank you for explaining that further.
Having gone through your logs, I see the ATV 4K playing as well. I see several playback sessions. Everything is without error with exception of the one iPad disconnecting.
I need to ask you to capture the logs the next time it faults again. Immediately after you restart PMS, grab the full set of logs like you did above and attach it here again. I’ll expect to see the error in Plex Media Server.1.log
ok i will do that once it happens again. Thanks you.
Hi. It happens again. PMS got disconnected and any devices can’t search for it.
Have downloaded the log after doing a reboot on my synology.
Please let me know how to fix it.
Is the Synology VM still in beta? Last I looked it was. Please advise (My DiskStation does not support VM)
Regarding your PMS, your Synology network adapters / network itself are shutting down
Notice here where your ethernet adapter is no longer visible
Dec 30, 2017 18:28:28.821 [0x7f23e17ff700] DEBUG - NetworkInterface: Notified of network changed (force=0)
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - Network interfaces:
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - * 1 lo (127.0.0.1) (loopback: 1)
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - * 9 ovs_eth1 (169.254.238.225) (loopback: 0)
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.822 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkInterface: received Netlink message len=84, type=RTM_GETADDR, flags=0x0
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkInterface: Netlink address message family=2, index=8, flags=0x80
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - Network change.
Dec 30, 2017 18:28:28.823 [0x7f23e17ff700] DEBUG - NetworkInterface: Notified of network changed (force=0)
Dec 30, 2017 18:28:28.823 [0x7f23e07ff700] DEBUG - NAT: UPnP, attempting port mapping.
Dec 30, 2017 18:28:28.823 [0x7f23e1111700] DEBUG - PublicAddressManager: Obtaining public IP.
Dec 30, 2017 18:28:28.824 [0x7f23e1111700] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Dec 30, 2017 18:28:28.824 [0x7f23e17ff700] DEBUG - Network change notification but nothing changed.
Dec 30, 2017 18:28:28.824 [0x7f23e17ff700] DEBUG - NetworkInterface: received Netlink message len=500, type=RTM_DELLINK, flags=0x0
Dec 30, 2017 18:28:28.824 [0x7f23e17ff700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=8, flags=0x1002, change=0xffffffff
Dec 30, 2017 18:28:28.825 [0x7f23e1111700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:28.825 [0x7f23e1111700] WARN - HTTP error requesting GET http://plex.tv/pms/:/ip (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:28.825 [0x7f23e1111700] ERROR - PublicAddressManager: Unable to get public IP adddress from myPlex (httpCode=-6):
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - NetworkInterface: received Netlink message len=1100, type=RTM_NEWLINK, flags=0x0
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=9, flags=0x1002, change=0x41
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - Network change.
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - NetworkInterface: Notified of network changed (force=0)
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - Network interfaces:
Dec 30, 2017 18:28:28.840 [0x7f23e17ff700] DEBUG - * 1 lo (127.0.0.1) (loopback: 1)
Dec 30, 2017 18:28:28.841 [0x7f23e17ff700] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 30, 2017 18:28:28.841 [0x7f23e17ff700] DEBUG - NetworkService: Dispatch network change after two second delay.
From this point forward, PMS frantically tries to shutdown in an orderly manner having been commanded to do so
plex.tv)Dec 30, 2017 18:28:28.867 [0x7f23c4b43700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:28.867 [0x7f23c4b43700] WARN - HTTP error requesting GET http://plex.tv/pms/:/ip (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:28.868 [0x7f23e1111700] WARN - MyPlex: Updating device connections failed, retrying in 10 seconds.
Dec 30, 2017 18:28:28.868 [0x7f23c4b43700] ERROR - PublicAddressManager: Unable to get public IP adddress from myPlex (httpCode=-6):
Dec 30, 2017 18:28:28.911 [0x7f23e07ff700] DEBUG - NAT: UPnP, didn't find usable IGD.
Dec 30, 2017 18:28:28.911 [0x7f23e07ff700] DEBUG - NAT: PMP, attempting mapping.
Dec 30, 2017 18:28:28.980 [0x7f23e07ff700] ERROR - NAT: PMP, map, couldn't initialize: -3:Unable to get Gateway
Dec 30, 2017 18:28:28.980 [0x7f23e07ff700] DEBUG - NAT: UPnP, attempting port mapping.
Dec 30, 2017 18:28:28.981 [0x7f23e07ff700] DEBUG - NAT: UPnP, didn't find usable IGD.
Dec 30, 2017 18:28:28.990 [0x7f23e07ff700] DEBUG - PublicAddressManager: Mapping failed.
Dec 30, 2017 18:28:29.005 [0x7f23c4b43700] DEBUG - MyPlex: Updating device connections (from timer: 0)
Dec 30, 2017 18:28:29.006 [0x7f23c4b43700] DEBUG - HTTP requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 30, 2017 18:28:29.006 [0x7f23c4b43700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:29.006 [0x7f23c4b43700] WARN - HTTP error requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:29.007 [0x7f23c4b43700] WARN - MyPlex: Updating device connections failed, retrying in 10 seconds.
Dec 30, 2017 18:28:29.009 [0x7f23e07ff700] DEBUG - MyPlex: Sending Server Info to myPlex (user=damianlin@protonmail.ch, ip=, port=0)
Dec 30, 2017 18:28:29.014 [0x7f23e07ff700] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=e3f1ce51-c724-4557-88bb-82da73f2556c
Dec 30, 2017 18:28:29.014 [0x7f23e07ff700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:29.014 [0x7f23e07ff700] WARN - HTTP error requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=e3f1ce51-c724-4557-88bb-82da73f2556c (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:29.015 [0x7f23e07ff700] DEBUG - MyPlex: Published Mapping State response was -6
Dec 30, 2017 18:28:29.015 [0x7f23e07ff700] WARN - MyPlex: Invalid response when mapping state (code=-6):
Dec 30, 2017 18:28:29.016 [0x7f23e07ff700] DEBUG - MyPlex: Updating device connections (from timer: 0)
Dec 30, 2017 18:28:29.017 [0x7f23e07ff700] DEBUG - HTTP requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 30, 2017 18:28:29.017 [0x7f23e07ff700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:29.017 [0x7f23e07ff700] WARN - HTTP error requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:29.018 [0x7f23e07ff700] WARN - MyPlex: Updating device connections failed, retrying in 10 seconds.
Dec 30, 2017 18:28:39.095 [0x7f23e07ff700] DEBUG - MyPlex: Updating device connections (from timer: 1)
Dec 30, 2017 18:28:39.095 [0x7f23e07ff700] DEBUG - HTTP requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 30, 2017 18:28:39.096 [0x7f23e07ff700] ERROR - Error issuing curl_easy_perform(handle): 6
Dec 30, 2017 18:28:39.096 [0x7f23e07ff700] WARN - HTTP error requesting PUT https://plex.tv/devices/a765c0aa91712ff6654b621ef09f0efaf602df5b?httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (0, No error) (Couldn't resolve host 'plex.tv')
Dec 30, 2017 18:28:39.096 [0x7f23e07ff700] WARN - MyPlex: Updating device connections failed, retrying in 20 seconds.
Dec 30, 2017 18:28:45.699 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.731 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.732 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.733 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.733 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.734 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.734 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.735 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.735 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.735 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 30, 2017 18:28:45.736 [0x7f23f6810800] DEBUG - Server is already in shutdown mode, ignoring this signal...
Hi.
I’m not using VM in my Synology.
You say that my network adapters/network itself are shutting down. But when PMS got disconnected, my Synology is still accessible remotely.
How can I solve this issue?
The last I saw ovs_eth0 is when the Virtual Switch was enabled in DSM.
It is only required for using VMs.
Can you disable the virtual switch, restoring you configuration to normal, and restarting DSM or do you have a requirement it be enabled ?
Hi. Do you know how can I disable the virtual switch? I’m not sure how to do it…
Ok. I have turned it off. Let’s see if that works.
Thank you!
