My 2 hour recording stopped at 6:27pm, 33 minutes short. About the time Plex when down. Why???
If Plex is shutdown then EVERYTHING Plex related stops working.
Did Plex crash or did you shut it down???
I was not referring to my server. I was referring to their http://plex.tv server.
Where did your graph come from?
Server debug logs for the time would normally have the clues
Here are the logs
@johnm_ColaSC said:
Where did your graph come from?
Looks to me like someone stopped Plex from the tray icon or possibly shutdown the server at 17:22:07 and then started it back up at 17:22:40:
58813 Dec 17, 2017 17:22:07.618 [14308] DEBUG - TrayIcon::WindowProc received WM_CLOSE
58814 Dec 17, 2017 17:22:07.629 [14308] DEBUG - Ordered to stop server.
58815 Dec 17, 2017 17:22:07.629 [14308] DEBUG - TrayIcon::WindowProc received WM_DESTROY
58816 Dec 17, 2017 17:22:07.630 [7680] DEBUG - Stopping server…
58817 Dec 17, 2017 17:22:07.630 [7680] DEBUG - HttpServer: Stopping server.
58818 Dec 17, 2017 17:22:07.630 [12252] DEBUG - TranscodeJobManager: [Running] onServerShutdown
58819 Dec 17, 2017 17:22:07.630 [12252] DEBUG - TranscodeJobManager: [Running] -> [Shutdown]
58820 Dec 17, 2017 17:22:07.630 [12252] DEBUG - MetadataItemClusterRequestHandler: a shutdown event has been received
58821 Dec 17, 2017 17:22:07.631 [7680] DEBUG - Server stopped.
58822 Dec 17, 2017 17:22:07.631 [7680] DEBUG - NetworkService: Stopping advertisement.
58823 Dec 17, 2017 17:22:07.631 [7680] DEBUG - Killing job.
58824 Dec 17, 2017 17:22:07.639 [7680] DEBUG - Job was already killed, not killing again.
58825 Dec 17, 2017 17:22:07.639 [7680] DEBUG - Stopping transcode session 38da1f4f-589b-4f97-8c0d-cd1148c07124
58826 Dec 17, 2017 17:22:07.639 [14432] DEBUG - DVR:Recorder: Asked to stop recording ‘The Sweetest Christmas (2017)’.
58827 Dec 17, 2017 17:22:07.639 [14432] DEBUG - DVR:Recorder: Stopping transcode session.
58828 Dec 17, 2017 17:22:07.639 [14432] DEBUG - Killing job.
58829 Dec 17, 2017 17:22:07.640 [12276] DEBUG - Jobs: ‘C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe’ exit code for process 8416 is -1059143458
58830 Dec 17, 2017 17:22:07.647 [14432] DEBUG - Job was already killed, not killing again.
58831 Dec 17, 2017 17:22:07.647 [14432] DEBUG - Stopping transcode session fec643d3-fe89-454b-b9d4-273bec901c24
58832 Dec 17, 2017 17:22:07.647 [14432] DEBUG - Cleaning directory for session fec643d3-fe89-454b-b9d4-273bec901c24 (C:\Temp\Transcoding\Transcode\Sessions\plex-transcode-fec643d3-fe89-454b-b9d4-273bec901c24)
58833 Dec 17, 2017 17:22:07.653 [7680] DEBUG - Whacked session 38da1f4f-589b-4f97-8c0d-cd1148c07124, 1 remaining.
58834 Dec 17, 2017 17:22:07.653 [7680] DEBUG - Job was already killed, not killing again.
58835 Dec 17, 2017 17:22:07.653 [7680] DEBUG - Job was already killed, not killing again.
58836 Dec 17, 2017 17:22:09.565 [14432] ERROR - Failed to delete session directory (boost::filesystem::remove: The process cannot access the file because it is being used by another process: “C:\Temp\Transcoding\Transcode\Sessions\plex-transcode-fec643d3-fe89-454b-b9d4-273bec901c24\media-03976.ts”)
58837 Dec 17, 2017 17:22:09.565 [12276] DEBUG - Jobs: ‘C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe’ exit code for process 16300 is -1059143458
58838 Dec 17, 2017 17:22:09.633 [14432] DEBUG - DVR:Grabber: Freed a tuner (now 3 available)
58839 Dec 17, 2017 17:22:09.634 [7680] DEBUG - Transcoder: Cleaning old transcode directories.
58840 Dec 17, 2017 17:22:09.634 [14432] DEBUG - DVR:Grabber: Recording for ‘The Sweetest Christmas (2017)’ stopped with status complete.
58841 Dec 17, 2017 17:22:09.634 [14360] DEBUG - DVR:Recorder: Asked to stop recording ‘The Sweetest Christmas (2017)’.
58842 Dec 17, 2017 17:22:09.634 [14432] DEBUG - DVR:Grabber: Using recording status.
58843 Dec 17, 2017 17:22:09.634 [14432] DEBUG - Activity: updated activity 24887d1e-9d24-4669-bf25-81f05cf64cb5 - completed 100% - Recording
58844 Dec 17, 2017 17:22:09.634 [14432] DEBUG - DVR:Grabber: Scheduling ‘The Sweetest Christmas (2017)’ for assimilation.
58845 Dec 17, 2017 17:22:09.636 [7680] DEBUG - Transcoder: Cleaning old transcode directory: C:\Temp\Transcoding\Transcode\Sessions\plex-transcode-38da1f4f-589b-4f97-8c0d-cd1148c07124-13475fd7-1b1c-4147-86dc-e21ef604646c
58846 Dec 17, 2017 17:22:09.636 [7680] DEBUG - Transcoder: Cleaning old transcode directory: C:\Temp\Transcoding\Transcode\Sessions\plex-transcode-fec643d3-fe89-454b-b9d4-273bec901c24
58847 Dec 17, 2017 17:22:09.636 [7680] ERROR - Transcoder: Failed to delete session directory (boost::filesystem::remove: The process cannot access the file because it is being used by another process: “C:\Temp\Transcoding\Transcode\Sessions\plex-transcode-fec643d3-fe89-454b-b9d4-273bec901c24\media-03976.ts”)
58848 Dec 17, 2017 17:22:09.637 [7680] DEBUG - Whacked session fec643d3-fe89-454b-b9d4-273bec901c24, 0 remaining.
58849 Dec 17, 2017 17:22:09.637 [7680] DEBUG - Killing plug-ins.
58850 Dec 17, 2017 17:22:09.637 [7680] DEBUG - [com.plexapp.system] Killing.
58851 Dec 17, 2017 17:22:09.637 [7680] DEBUG - [com.plexapp.plugins.WebTools] Killing.
58852 Dec 17, 2017 17:22:09.637 [7680] DEBUG - Waiting for Plex Tuner Service.exe to exit.
58853 Dec 17, 2017 17:22:09.639 [16560] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.tms://movie/MV010275970000 thumb: http://tmsimg.plex.tv/assets/p14422625_v_v5_ab.jpg title: The Sweetest Christmas type: 1 year: 2017’ to library item
58854 Dec 17, 2017 17:22:09.640 [16560] DEBUG - DVR:Grabber: Postprocessing, we’re going to put The Sweetest Christmas (2017)
in O:\Public\Plex Recordings\The Sweetest Christmas (2017)\The Sweetest Christmas (2017).ts
58855 Dec 17, 2017 17:22:09.641 [16560] DEBUG - DVR:Grabber: Moving O:\Public\Plex Recordings.grab\da55c9de02fd51e56316807513dd4456c0c9d6f4\The Sweetest Christmas (2017).ts to O:\Public\Plex Recordings\The Sweetest Christmas (2017)\The Sweetest Christmas (2017).ts
58856 Dec 17, 2017 17:22:09.642 [4932] INFO - Library section 7 (Movies) will be updated because of a change in O:\Public\Plex Recordings\The Sweetest Christmas (2017)
58857 Dec 17, 2017 17:22:09.642 [4932] INFO - Library section 8 (TV Shows) will be updated because of a change in O:\Public\Plex Recordings\The Sweetest Christmas (2017)
58858 Dec 17, 2017 17:22:09.644 [16560] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.tms://movie/MV010275970000 thumb: http://tmsimg.plex.tv/assets/p14422625_v_v5_ab.jpg title: The Sweetest Christmas type: 1 year: 2017’ to library item
58859 Dec 17, 2017 17:22:09.647 [16560] DEBUG - Added new metadata item (The Sweetest Christmas) with ID 85679
58860 Dec 17, 2017 17:22:09.647 [16560] DEBUG - Doing expensive tags write for ‘The Sweetest Christmas’ because something changed.
58861 Dec 17, 2017 17:22:09.648 [16560] DEBUG - Doing expensive tags write for ‘The Sweetest Christmas’ because something changed.
58862 Dec 17, 2017 17:22:09.649 [16720] DEBUG - HubCache: Expiring ‘1/home.movies.recent/hubs/12/en’ because of event plex.event.item.created.
58863 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.movies.recent/hubs/20/en-US;q=1’ because of event plex.event.item.created.
58864 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.movies.recent/hubs/6/en-us’ because of event plex.event.item.created.
58865 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.movies.recent/hubs/6/en_US’ because of event plex.event.item.created.
58866 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.ondeck/hubs/20/en-US;q=1’ because of event plex.event.item.created.
58867 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.ondeck/hubs/6/en_US’ because of event plex.event.item.created.
58868 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.videos.recent/hubs/12/en’ because of event plex.event.item.created.
58869 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.videos.recent/hubs/20/en-US;q=1’ because of event plex.event.item.created.
58870 Dec 17, 2017 17:22:09.650 [16720] DEBUG - HubCache: Expiring ‘1/home.videos.recent/hubs/6/en-us’ because of event plex.event.item.created.
58871 Dec 17, 2017 17:22:09.651 [16720] DEBUG - HubCache: Expiring ‘1/home.videos.recent/hubs/6/en_US’ because of event plex.event.item.created.
58872 Dec 17, 2017 17:22:09.655 [16560] DEBUG - Doing expensive tags write for ‘The Sweetest Christmas’ because something changed.
58873 Dec 17, 2017 17:22:09.656 [16560] DEBUG - Updating metadata item (save) (The Sweetest Christmas) with ID 85679
58874 Dec 17, 2017 17:22:09.673 [1056] DEBUG - Plex Tuner Service.exe exited.
58875 Dec 17, 2017 17:22:09.673 [8260] DEBUG - Media Analyzer: Performing on-the-fly analysis on 1 item.
58876 Dec 17, 2017 17:22:09.674 [8260] DEBUG - JobRunner: exec of C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe cancelled. In shutdown state.
58877 Dec 17, 2017 17:22:09.674 [8260] ERROR - On the fly analysis failed to start
58878 Dec 17, 2017 17:22:09.674 [8260] DEBUG - Media Analyzer: Background analysis completed in 0.0 seconds, removing 1 IDs
58879 Dec 17, 2017 17:22:09.674 [8260] DEBUG - Killing job.
58880 Dec 17, 2017 17:22:09.679 [16560] DEBUG - DVR:Assimilator: Refreshing ‘The Sweetest Christmas (2017)’ (guid: com.gracenote.tms://movie/MV010275970000) with force: 0
58881 Dec 17, 2017 17:22:09.679 [16560] DEBUG - Matching ‘The Sweetest Christmas’ (ID 85679) with agent com.plexapp.agents.imdb
58882 Dec 17, 2017 17:22:09.680 [16560] DEBUG - Issuing search query: http://127.0.0.1:32400/system/agents/search?mediaType=1&id=85679&identifier=com.plexapp.agents.imdb&duration=-1&filename=O%3A%5CPublic%5CPlex%20Recordings%5CThe%20Sweetest%20Christmas%20(2017)%5CThe%20Sweetest%20Christmas%20(2017)%2Ets&lang=en&openSubtitlesHash=fdfb2cef80e246f4&plexHash=c312025d7c482f30430554fcafe5ae39b32ba393&name=The%20Sweetest%20Christmas&year=2017
58883 Dec 17, 2017 17:22:09.681 [16560] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/search?mediaType=1&id=85679&identifier=com.plexapp.agents.imdb&duration=-1&filename=O%3A%5CPublic%5CPlex%20Recordings%5CThe%20Sweetest%20Christmas%20(2017)%5CThe%20Sweetest%20Christmas%20(2017)%2Ets&lang=en&openSubtitlesHash=fdfb2cef80e246f4&plexHash=c312025d7c482f30430554fcafe5ae39b32ba393&name=The%20Sweetest%20Christmas&year=2017
58884 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Killing job.
58885 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Database: Shutting down.
58886 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Captured session 0.
58887 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Captured session 1.
58888 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Captured session 2.
58889 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Captured session 3.
58890 Dec 17, 2017 17:22:09.727 [7680] DEBUG - Captured session 4.
58891 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 5.
58892 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 6.
58893 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 7.
58894 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 8.
58895 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 9.
58896 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 10.
58897 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 11.
58898 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 12.
58899 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 13.
58900 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 14.
58901 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 15.
58902 Dec 17, 2017 17:22:09.728 [7680] DEBUG - Captured session 16.
58903 Dec 17, 2017 17:22:09.729 [7680] DEBUG - Captured session 17.
58904 Dec 17, 2017 17:22:09.729 [7680] DEBUG - Captured session 18.
58905 Dec 17, 2017 17:22:09.729 [7680] DEBUG - Captured session 19.
58906 Dec 17, 2017 17:22:09.761 [7680] DEBUG - Database: Shutting down.
58907 Dec 17, 2017 17:22:09.761 [7680] DEBUG - Captured session 0.
58908 Dec 17, 2017 17:22:09.761 [7680] DEBUG - Captured session 1.
58909 Dec 17, 2017 17:22:40.710 [7396] INFO - Plex Media Server v1.10.1.4602-f54242b6b - Microsoft PC x64 - build: windows-i386 english - GMT -05:00
Possibly a new server version installed? I see in the logs at 16:05 that the version is 1.10.1.4561, then at startup at 17:22:40 the version is 1.10.1.4602.
Dec 17, 2017 16:05:33.915 [16940] INFO - Plex Media Server v1.10.1.4561-9de2951fc - Microsoft PC x64 - build: windows-i386 english - GMT -05:00
58909 Dec 17, 2017 17:22:40.710 [7396] INFO - Plex Media Server v1.10.1.4602-f54242b6b - Microsoft PC x64 - build: windows-i386 english - GMT -05:00
Thanks, now I need to find out who in my household did it. Is it possible to not notify of updates in any of the clients and only have it popup on the server as a balloon notification? I run my server on Windows 10. I do not want it updating automatically.
I leave my setting for Server version updates set to Ask me so new updates are only applied when I tell it to which is always during periods with no recordings. I also generally test multiple simultaneous recordings over a couple of hours to make sure there are no issues with the new version. Only the admin account should be able to apply updates. I don’t get the notification on clients if logged in with other user accounts.
That is what I have. Until the Live TV and DVR are rolled out to non-admin users, everyone has access to the admin account. I guess that the risk I will have to take.
Yeah, that would be a problem. On the bright side that is a feature Plex is looking at and hopefully will be released in the near future.