PMS refuses to run on Synology

Server Version#:1.18.4.2171-ac2afe5f8
Player Version#:DSM6.2.2-24922 Update 4

Trouble shooting included.

  1. Full reboot
  2. Uninstall and re install PMS

All other installed packages are running just fine. In the package center i click on the run button, and it attempts to open, but then stops.

No setting that I know of have been changed., the only issue today was intermittent internet connection.

Below is what I hope is the correct logs.
Sorry if the Verbose is an issue, but i couldn’t find the settings to ignore it.

Jan 15, 2020 17:46:16.528 [0x7f38d6fb2700] INFO - Plex Media Server v1.18.4.2171-ac2afe5f8 - Synology DS718+ x86_64 - build: linux-x86_64 synology - GMT 02:00
Jan 15, 2020 17:46:16.528 [0x7f38d6fb2700] INFO - Linux version: DSM 6.2.2.24922-4, language: en-US
Jan 15, 2020 17:46:16.528 [0x7f38d6fb2700] INFO - Processor Intel(R) Celeron(R) CPU J3455 @ 1.50GHz
Jan 15, 2020 17:46:16.528 [0x7f38d6fb2700] INFO - /var/packages/Plex Media Server/target/Plex Media Server
Jan 15, 2020 17:46:16.527 [0x7f38e1656740] DEBUG - BPQ: [Idle] -> [Starting]
Jan 15, 2020 17:46:16.527 [0x7f38e1656740] VERBOSE - BPQ: delaying processing 120 second(s)
Jan 15, 2020 17:46:16.528 [0x7f38e1656740] DEBUG - FeatureManager: Using cached data for features list
Jan 15, 2020 17:46:16.529 [0x7f38e1656740] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.26.0, threadsafe=1
Jan 15, 2020 17:46:16.599 [0x7f38e1656740] DEBUG - Running migrations. (EPG 0)
Jan 15, 2020 17:46:16.722 [0x7f38e1656740] DEBUG - ChangestampAllocator: initialized to 4581382
Jan 15, 2020 17:46:16.722 [0x7f38e1656740] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.26.0, threadsafe=1
Jan 15, 2020 17:46:16.729 [0x7f38e1656740] DEBUG - Running migrations. (EPG 0)
Jan 15, 2020 17:46:16.729 [0x7f38e1656740] VERBOSE - [FFMPEG] - Rescanning for external libs: '/volume1/Plex/Library/Application\ Support/Plex\ Media\ Server/Codecs/8bf330d-2818-linux-x86_64/'
Jan 15, 2020 17:46:16.729 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libh264_decoder.so
Jan 15, 2020 17:46:16.730 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/liblibx264_encoder.so
Jan 15, 2020 17:46:16.731 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libaac_encoder.so
Jan 15, 2020 17:46:16.731 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libhevc_decoder.so
Jan 15, 2020 17:46:16.732 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmpeg4_decoder.so
Jan 15, 2020 17:46:16.732 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmp3_decoder.so
Jan 15, 2020 17:46:16.733 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libwmav2_decoder.so
Jan 15, 2020 17:46:16.733 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmpeg1video_decoder.so
Jan 15, 2020 17:46:16.734 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/librv20_decoder.so
Jan 15, 2020 17:46:16.734 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libwmv3_decoder.so
Jan 15, 2020 17:46:16.735 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libwmv1_decoder.so
Jan 15, 2020 17:46:16.735 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libsvq3_decoder.so
Jan 15, 2020 17:46:16.736 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmsmpeg4v3_decoder.so
Jan 15, 2020 17:46:16.736 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libac3_decoder.so
Jan 15, 2020 17:46:16.736 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libaac_decoder.so
Jan 15, 2020 17:46:16.737 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmp2_decoder.so
Jan 15, 2020 17:46:16.737 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libindeo3_decoder.so
Jan 15, 2020 17:46:16.738 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libwmalossless_decoder.so
Jan 15, 2020 17:46:16.738 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libmp1_decoder.so
Jan 15, 2020 17:46:16.738 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/liblibmp3lame_encoder.so
Jan 15, 2020 17:46:16.739 [0x7f38e1656740] VERBOSE - [FFMPEG] - Loading external lib /volume1/Plex/Library/Application Support/Plex Media Server/Codecs/8bf330d-2818-linux-x86_64/libvp9_decoder.so
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] DEBUG - CERT: Installed certificate with fingerprint d7:cf:53:a2:1f:6e:c0:31:b8:b4:1a:db:32:0f:38:f6:97:28:e7:65.
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] DEBUG - CERT: Installed new private key.
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] DEBUG - CERT: Subject name is /C=US/ST=California/L=Los Gatos/O=Plex, Inc./CN=*.140f3eba063c4266b06d0412684b3723.plex.direct
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] DEBUG - CERT: OCSP requests for stapling will be made to 'http://ocspx.digicert.com/'.
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] VERBOSE - CERT: Successfully generated OCSP stapling request
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] INFO - OCSP: Successfully retrieved response from cache.
Jan 15, 2020 17:46:16.753 [0x7f38e1656740] DEBUG - CERT: Installed intermediate certificate.
Jan 15, 2020 17:46:16.754 [0x7f38e1656740] DEBUG - HttpServer: Listening on IPv6 as well as IPv4.
Jan 15, 2020 17:46:16.754 [0x7f38e1656740] DEBUG - HttpServer: Listening on port 32400.
Jan 15, 2020 17:46:16.754 [0x7f38e1656740] DEBUG - HttpServer: Listening on port 32401.
Jan 15, 2020 17:46:16.759 [0x7f38e1656740] INFO - Killing process: Plex Plug-in [com.plexapp.system] (pid: 30161)
Jan 15, 2020 17:46:16.767 [0x7f38cdfe5700] DEBUG - Grabber: Cleaning up orphaned grabs.
Jan 15, 2020 17:46:16.768 [0x7f38e1656740] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Jan 15, 2020 17:46:16.768 [0x7f38e1656740] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Jan 15, 2020 17:46:16.768 [0x7f38cdcf7700] DEBUG - Relay: read 55 cached entries from hosts file
Jan 15, 2020 17:46:16.769 [0x7f38e1656740] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Jan 15, 2020 17:46:16.769 [0x7f38cdcf7700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:16.769 [0x7f38e1656740] DEBUG - MyPlex: updating with 10 access tokens
Jan 15, 2020 17:46:16.769 [0x7f38cdfe5700] DEBUG - Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Jan 15, 2020 17:46:16.770 [0x7f38ce8af700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Jan 15, 2020 17:46:16.770 [0x7f38e1656740] DEBUG - Opening 1 database sessions to library (), SQLite 3.26.0, threadsafe=1
Jan 15, 2020 17:46:16.771 [0x7f38ce8af700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Jan 15, 2020 17:46:16.777 [0x7f38a7fff700] DEBUG - File "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-ac2afe5f8" changed: -1 => 2019-12-20 21:15:36 (1576869336).
Jan 15, 2020 17:46:16.777 [0x7f38a7fff700] DEBUG - File "/volume1/Plex/Library/Application Support/Plex Media Server/Plug-ins" changed: -1 => 2018-12-16 07:14:23 (1544937263).
Jan 15, 2020 17:46:16.777 [0x7f38a7fff700] DEBUG - Scanning for plug-ins in "/volume1/@appstore/Plex Media Server/Resources/Plug-ins-ac2afe5f8"
Jan 15, 2020 17:46:16.779 [0x7f38a7fff700] DEBUG - Scanning for plug-ins in "/volume1/Plex/Library/Application Support/Plex Media Server/Plug-ins"
Jan 15, 2020 17:46:16.779 [0x7f38a7fff700] DEBUG - PluginRepository::setStartState: 1, startingSystem
Jan 15, 2020 17:46:16.779 [0x7f38a7fff700] DEBUG - Starting plug-in /volume1/@appstore/Plex Media Server/Resources/Plug-ins-ac2afe5f8/System.bundle.
Jan 15, 2020 17:46:16.779 [0x7f38a7fff700] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Jan 15, 2020 17:46:16.780 [0x7f38a7fff700] DEBUG - Starting file watcher for com.plexapp.system
Jan 15, 2020 17:46:16.780 [0x7f38a7fff700] VERBOSE - Plugin: setting environment variable: 'PYTHONHOME=/volume1/@appstore/Plex Media Server/Resources/Python'
Jan 15, 2020 17:46:16.780 [0x7f38a7fff700] VERBOSE - Plugin: setting PLEXTOKEN for plugin
Jan 15, 2020 17:46:16.781 [0x7f38a7fff700] DEBUG - Spawned plug-in com.plexapp.system with PID 30591
Jan 15, 2020 17:46:16.781 [0x7f38a7fff700] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Jan 15, 2020 17:46:17.784 [0x7f38cdcf7700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:17.850 [0x7f38ce8af700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Jan 15, 2020 17:46:17.852 [0x7f38ce8af700] DEBUG - MyPlex: updating with 10 access tokens
Jan 15, 2020 17:46:17.852 [0x7f38cdfe5700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:18.844 [0x7f38cdfe5700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:18.845 [0x7f38cdfe5700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:19.875 [0x7f38cdfe5700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:19.876 [0x7f38cd50e700] DEBUG - Job running: '/volume1/@appstore/Plex Media Server/CrashUploader' '--directory=/volume1/Plex/Library/Application Support/Plex Media Server/Crash Reports/1.18.4.2171-ac2afe5f8' '--version=1.18.4.2171-ac2afe5f8' '--platform=Linux' '--platformVersion=DSM 6.2.2.24922-4' '--serverUuid=227922cb6a3d9268cbaa0c711b1db4ec3b453e77' '--userId=hamish@barramoz.com' '--sentryUrl=https://sentry.io/api/1233455/minidump' '--sentryKey=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx' '--vendor=Synology' '--model=x86_64' '--device=DS718+'
Jan 15, 2020 17:46:19.876 [0x7f38cdcf7700] DEBUG - HTTP requesting GET https://music.provider.plex.tv?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 15, 2020 17:46:19.877 [0x7f38cd50e700] DEBUG - Jobs: Starting child process with pid 30624
Jan 15, 2020 17:46:19.894 [0x7f38d6cc4700] VERBOSE - JobManager: child process with handle 30624 exited
Jan 15, 2020 17:46:19.895 [0x7f38d6cc4700] DEBUG - Jobs: '/volume1/@appstore/Plex Media Server/CrashUploader' exit code for process 30624 is 0 (success)
Jan 15, 2020 17:46:21.013 [0x7f38a7fff700] DEBUG - Reading 486 bytes in the body, code is 200
Jan 15, 2020 17:46:21.013 [0x7f38a7fff700] DEBUG - [com.plexapp.system] Plug-in running on port 39369.
Jan 15, 2020 17:46:21.013 [0x7f38a7fff700] DEBUG -  * Plug-in handles prefix: /system
Jan 15, 2020 17:46:21.013 [0x7f38a7fff700] DEBUG -  * Plug-in handles prefix: /player
Jan 15, 2020 17:46:21.013 [0x7f38a7fff700] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Jan 15, 2020 17:46:21.014 [0x7f38a7fff700] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Jan 15, 2020 17:46:21.014 [0x7f38a7fff700] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Jan 15, 2020 17:46:21.014 [0x7f38a7fff700] DEBUG - Updating the list of agents known by the system.
Jan 15, 2020 17:46:21.014 [0x7f38a7fff700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Jan 15, 2020 17:46:21.014 [0x7f38a7fff700] DEBUG - HTTP requesting GET http://127.0.0.1:39369/system/agents
Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, database corruption at line 64757 of [bf8c1b2b7a]
Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, database corruption at line 64798 of [bf8c1b2b7a]
Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, statement aborts at 25: [insert into plugins (identifier,framework_version,access_count,installed_at,accessed_at,modified_at) values (:plugins_identifier,:plugins_framework_version,:plugins_access_count,:plugi
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Exception inside transaction (inside=1) (../Plugins/PluginDatabaseState.cpp:135): sqlite3_statement_backend::loadOne: database disk image is malformed
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Exception inside transaction (inside=1) (../Plugins/PluginDatabaseState.cpp:49): sqlite3_statement_backend::loadOne: database disk image is malformed
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Error: Unable to set up server: sqlite3_statement_backend::loadOne: database disk image is malformed (N4soci10soci_errorE)

Mod-Edit: put some code tags around your log to make it readable :wink:

PMS Settings → General → Show Advanced


Based on error messages, it looks like you’ve database corruption.

Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, database corruption at line 64757 of [bf8c1b2b7a]
Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, database corruption at line 64798 of [bf8c1b2b7a]
Jan 15, 2020 17:46:21.015 [0x7f38e1656740] ERROR - SQLITE3:(nil), 11, statement aborts at 25: [insert into plugins (identifier,framework_version,access_count,installed_at,accessed_at,modified_at) values (:plugins_identifier,:plugins_framework_version,:plugins_access_count,:plugi
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Exception inside transaction (inside=1) (…/Plugins/PluginDatabaseState.cpp:135): sqlite3_statement_backend::loadOne: database disk image is malformed
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Exception inside transaction (inside=1) (…/Plugins/PluginDatabaseState.cpp:49): sqlite3_statement_backend::loadOne: database disk image is malformed
Jan 15, 2020 17:46:21.016 [0x7f38e1656740] ERROR - Error: Unable to set up server: sqlite3_statement_backend::loadOne: database disk image is malformed (N4soci10soci_errorE)

Repair a Corrupt Database has information on how to attempt repairs.

If you do not need to keep metadata, users, watched status, etc, it may be easier to completely remove Plex from your NAS, then re-download the package from plex.tv, and start over.

See this post for info on completely removing Plex from your Synology. Your media will not be touched (unless you have it in the Plex shared folder, which is a bad thing and will cause problems).

1 Like

Here is how you can use File Station to repair the corrupt database using backups

Thanks for the help.
Ended up doing a clean install. I had been meaning to move my media out of the Plex folder for a while now. So the clean install was a good excuse to do it.

Thanks again for all the great advice.

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