Plex Server running smoothly with PMS Service until update to PlexMediaServer-1.15.3.876 is installed.
I have uninstalled both Plex and PMS Service then installed PlexMediaServer-1.15.3.876 again, still not working.
It seems to shut down plex after a bit when I run it manually, can’t connect to server either
I am suspecting it may be the antivirus, log is below, any help appreciated
Apr 07, 2019 13:05:16.908 [1960] INFO - Plex Media Server v1.15.3.876-ad6e39743 - Microsoft PC x64 - build: windows-x86 windows - GMT -07:00
Apr 07, 2019 13:05:16.908 [1960] INFO - Windows version: 6.1 (Build 7601), language en-US
Apr 07, 2019 13:05:16.908 [1960] INFO - 4 3591 MHz processor(s): Architecture=0, Level=6, Revision=15363 Processor Identifier=Intel64 Family 6 Model 60 Stepping 3, GenuineIntel
Apr 07, 2019 13:05:16.908 [1960] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Server.exe"
Apr 07, 2019 13:05:16.939 [1848] DEBUG - BPQ: [Idle] -> [Starting]
Apr 07, 2019 13:05:17.001 [1848] DEBUG - FeatureManager: Using cached data for features list
Apr 07, 2019 13:05:17.001 [1848] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.26.0, threadsafe=1
Apr 07, 2019 13:05:17.110 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.188 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.204 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.220 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.220 [1848] INFO - SQLITE3:0x322232e0, 283, recovered 53 frames from WAL file F:\Plex\local application data\Plex Media Server\Plug-in Support\Databases\com.plexapp.plugins.library.db-wal
Apr 07, 2019 13:05:17.220 [1848] DEBUG - Running migrations. (EPG 0)
Apr 07, 2019 13:05:17.282 [1848] DEBUG - ChangestampAllocator: initialized to 4152884
Apr 07, 2019 13:05:17.282 [1848] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.26.0, threadsafe=1
Apr 07, 2019 13:05:17.329 [1848] DEBUG - Running migrations. (EPG 0)
Apr 07, 2019 13:05:18.343 [1848] DEBUG - HttpServer: Listening on port 32400 with queue of 2147483647 connections.
Apr 07, 2019 13:05:18.343 [1848] DEBUG - HttpServer: Listening on port 32401 with queue of 2147483647 connections.
Apr 07, 2019 13:05:18.421 [1324] DEBUG - DVR:Grabber: Cleaning up orphaned grabs.
Apr 07, 2019 13:05:18.436 [1848] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Apr 07, 2019 13:05:18.436 [1848] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Apr 07, 2019 13:05:18.436 [1308] DEBUG - Relay: read 55 cached entries from hosts file
Apr 07, 2019 13:05:18.436 [1308] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:18.436 [1848] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/541b4f5bb24e151db1df60c67e5c77a09c19634c/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Apr 07, 2019 13:05:18.468 [1848] DEBUG - MyPlex: updating with 32 access tokens
Apr 07, 2019 13:05:18.483 [1300] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Apr 07, 2019 13:05:18.483 [1848] DEBUG - Opening 1 database sessions to library (), SQLite 3.26.0, threadsafe=1
Apr 07, 2019 13:05:18.483 [1300] DEBUG - HTTP requesting GET https://plex.tv/servers/541b4f5bb24e151db1df60c67e5c77a09c19634c/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Apr 07, 2019 13:05:18.483 [1324] DEBUG - DVR:Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Apr 07, 2019 13:05:18.530 [2052] DEBUG - File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743" changed: -1 => 2019-04-06 07:45:20 (1554561920).
Apr 07, 2019 13:05:18.530 [2052] DEBUG - File "F:\Plex\local application data\Plex Media Server\Plug-ins" changed: -1 => 2018-12-16 04:41:07 (1544964067).
Apr 07, 2019 13:05:18.530 [2052] DEBUG - Scanning for plug-ins in "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743"
Apr 07, 2019 13:05:18.826 [2052] DEBUG - Scanning for plug-ins in "F:\Plex\local application data\Plex Media Server\Plug-ins"
Apr 07, 2019 13:05:18.858 [2052] DEBUG - PluginRepository::setStartState: 1, startingSystem
Apr 07, 2019 13:05:18.858 [2052] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743\System.bundle.
Apr 07, 2019 13:05:18.858 [2052] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Apr 07, 2019 13:05:18.889 [2052] DEBUG - Starting file watcher for com.plexapp.system
Apr 07, 2019 13:05:18.889 [2052] DEBUG - Plugin::createProcess: Creating plugin process: "C:\Program Files (x86)\Plex\Plex Media Server\PlexScriptHost.exe" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743\System.bundle"
Apr 07, 2019 13:05:18.889 [2052] DEBUG - Spawned plug-in com.plexapp.system with PID 2068
Apr 07, 2019 13:05:18.889 [2052] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Apr 07, 2019 13:05:18.936 [0360] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe "--directory=F:\Plex\local application data\Plex Media Server\Crash Reports\1.15.3.876-ad6e39743" --version=1.15.3.876-ad6e39743 --platform=Windows "--platformVersion=6.1 (Build 7601)" --serverUuid=541b4f5bb24e151db1df60c67e5c77a09c19634c --userId=plex@myemaild.com --sentryUrl=https://sentry.io/api/1233455/minidump --sentryKey=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx --vendor=Microsoft --model=x64 --device=PC
Apr 07, 2019 13:05:18.936 [0360] DEBUG - Jobs: Starting child process with pid 2088
Apr 07, 2019 13:05:19.232 [1308] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:19.310 [1300] DEBUG - HTTP 200 response from GET https://plex.tv/servers/541b4f5bb24e151db1df60c67e5c77a09c19634c/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Apr 07, 2019 13:05:19.310 [1300] DEBUG - MyPlex: updating with 33 access tokens
Apr 07, 2019 13:05:19.310 [1308] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:20.043 [1308] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:20.043 [1308] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:20.246 [0356] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe' exit code for process 2088 is 0 (success)
Apr 07, 2019 13:05:20.745 [1308] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:20.745 [1308] DEBUG - HTTP requesting GET https://music.provider.plex.tv?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:21.151 [1308] DEBUG - HTTP 200 response from GET https://music.provider.plex.tv?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:21.151 [1308] DEBUG - HTTP requesting GET https://music.provider.plex.tv?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:21.478 [1308] DEBUG - HTTP 200 response from GET https://music.provider.plex.tv?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Apr 07, 2019 13:05:28.436 [1324] DEBUG - DVR:Device: Discovering and refreshing all devices.
Apr 07, 2019 13:05:28.436 [1324] DEBUG - Creating NetworkServices singleton.
Apr 07, 2019 13:05:28.436 [1324] DEBUG - NetworkService: Creating new service.
Apr 07, 2019 13:05:28.436 [1324] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Apr 07, 2019 13:05:28.436 [1324] DEBUG - NetworkService: Quick dispatch of network change.
Apr 07, 2019 13:05:28.436 [1324] DEBUG - DVR:Grabber: HDHomerun discovered 0 compatible devices.
Apr 07, 2019 13:05:28.436 [1324] DEBUG - HTTP requesting POST http://127.0.0.1:32600/devices/discover
Apr 07, 2019 13:05:28.436 [1676] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Apr 07, 2019 13:05:28.436 [1676] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901 (outbound: 0)
Apr 07, 2019 13:05:29.653 [1324] ERROR - Error issuing curl_easy_perform(handle): 7
Apr 07, 2019 13:05:29.653 [1324] WARN - HTTP error requesting POST http://127.0.0.1:32600/devices/discover (0, No error) (Failed to connect to 127.0.0.1 port 32600: Connection refused)
Apr 07, 2019 13:05:29.653 [1324] DEBUG - DVR:Grabber: Failed to retrieve device data
Apr 07, 2019 13:07:16.950 [2524] DEBUG - BPQ: [Starting] -> [Processing]
Apr 07, 2019 13:07:17.075 [2524] DEBUG - BPQ: generating queue items from 0 generator(s)
Apr 07, 2019 13:07:17.075 [2524] DEBUG - BPQ: generated 0 item(s) for queue
Apr 07, 2019 13:07:17.075 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:17.090 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=1): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:17.465 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:17.465 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=2): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:18.213 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:18.213 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=3): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:18.713 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:18.713 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=4): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:19.711 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:19.711 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=5): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:20.709 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:20.709 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=6): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:21.708 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:21.708 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=7): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:22.722 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:22.722 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=8): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:23.720 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:23.720 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=9): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:24.719 [2524] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 1: [BEGIN IMMEDIATE] attempt to write a readonly database
Apr 07, 2019 13:07:24.719 [2524] ERROR - Failed to begin transaction (..\BackgroundProcessing\BackgroundProcessingQueue.cpp:41) (tries=10): Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:07:24.719 [2524] ERROR - Thread: Uncaught exception running async task which was spawned by thread 4288: Cannot begin transaction. attempt to write a readonly database
Apr 07, 2019 13:08:18.913 [2052] ERROR - Timeout or error reading status line from plug-in pipe [com.plexapp.system], we're killing it.
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Stopping [com.plexapp.system].
Apr 07, 2019 13:08:18.913 [2052] DEBUG - [com.plexapp.system] Killing.
Apr 07, 2019 13:08:18.913 [2052] ERROR - Error received reading configuration for com.plexapp.system
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Stopping [com.plexapp.system].
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Apr 07, 2019 13:08:18.913 [2052] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Updating the list of agents known by the system.
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Starting file watcher for com.plexapp.system
Apr 07, 2019 13:08:18.913 [2052] DEBUG - Plugin::createProcess: Creating plugin process: "C:\Program Files (x86)\Plex\Plex Media Server\PlexScriptHost.exe" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-ad6e39743\System.bundle"
Apr 07, 2019 13:08:18.929 [2052] DEBUG - Spawned plug-in com.plexapp.system with PID 3928
Apr 07, 2019 13:08:18.929 [2052] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Apr 07, 2019 13:08:18.929 [1848] DEBUG - Image transcode cache directory: "F:\Plex\local application data\Plex Media Server\Cache\PhotoTranscoder"
Apr 07, 2019 13:08:18.929 [1848] DEBUG - Transcoder: Cleaning old transcode directories.
Apr 07, 2019 13:08:18.991 [1848] ERROR - SQLITE3:0x322232e0, 8, statement aborts at 26: [update external_metadata_sources set online=0] attempt to write a readonly database
Apr 07, 2019 13:08:19.069 [1848] ERROR - Error: Unable to set up server: sqlite3_statement_backend::loadOne: attempt to write a readonly database (class soci::soci_error)
