Plex DVR records only a small snippet of a program from a random point in the show.

General Discussions Plex Features
1

I had three movies set to record on my Plex Server on MacOS. They showed up in the library and I’ve only recently gone to try and watch them. Each only had about 45-120 seconds of the movie recorded. The files were under 15MB. Not sure why it recorded such a small random chunk of the program.

I also noticed that the program guide takes FOREVER to download.

Any ideas?

Feb 07, 2018 22:31:59.239 [0x700010e94000] DEBUG - DVR:Grabber: Starting operation for ‘Witness (1985)’.
Feb 07, 2018 22:31:59.249 [0x700010e94000] DEBUG - DVR:Grabber: HDHomerun starting a media grab on device device://tv.plex.grabbers.hdhomerun/1327C935 (Silicondust HDHomeRun PRIME, supported) tuner 0.
Feb 07, 2018 22:31:59.346 [0x700010e94000] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.tms://movie/MV000186450000 thumb: http://tmsimg.plex.tv/assets/p8671_v_v5_aa.jpg title: Witness type: 1 year: 1985’ to library item
Feb 07, 2018 22:31:59.957 [0x70000fa9f000] DEBUG - DVR:Device: Device was alive, refreshed device://tv.plex.grabbers.hdhomerun/1327C935.
Feb 07, 2018 22:31:59.958 [0x70000fa9f000] DEBUG - DVR:Grabber: Mystery discovered 0 compatible devices.
Feb 07, 2018 22:32:09.226 [0x700010e94000] DEBUG - DVR:Grabber: Saving recording to /Volumes/Media_Alpha/Movies/.grab/f94b8c7aaeff59d14e6ec74a153bc27c3b55fa54
Feb 07, 2018 22:32:11.080 [0x700010e94000] DEBUG - DVR:Grabber: Going to record for 6171 seconds, final URL is http://192.168.1.195:5004/auto/v746
Feb 07, 2018 22:32:11.084 [0x70000ffbd000] DEBUG - DVR:Device: Discovering and refreshing devices.
Feb 07, 2018 22:32:11.086 [0x70000ffbd000] DEBUG - DVR:Grabber: HDHomerun discovered a model HDHR3-CC.
Feb 07, 2018 22:32:11.089 [0x700010e94000] DEBUG - DVR:Grabber: Setting timer to stop grab of ‘Witness (1985)’ in 6169 seconds.
Feb 07, 2018 22:32:11.089 [0x700010e94000] DEBUG - DVR:Segmenter: Creating a new recorder for http://192.168.1.195:5004/auto/v746.
Feb 07, 2018 22:32:11.098 [0x70000ffbd000] DEBUG - DVR:Grabber: HDHomerun discovered 1 compatible devices.
Feb 07, 2018 22:32:11.098 [0x70000ffbd000] DEBUG - DVR:Device: Testing grabber HDHomerun device device://tv.plex.grabbers.hdhomerun/1327C935 at http://192.168.1.195:80
Feb 07, 2018 22:32:11.118 [0x70000ffbd000] DEBUG - DVR:Device: Device was alive, refreshed device://tv.plex.grabbers.hdhomerun/1327C935.
Feb 07, 2018 22:32:11.118 [0x700010e94000] DEBUG - DVR:Grabber: Waiting for a tuner (3 available).
Feb 07, 2018 22:32:11.118 [0x700010e94000] DEBUG - DVR:Grabber: Allocated a tuner (2 left)
Feb 07, 2018 22:32:11.118 [0x70000ffbd000] DEBUG - DVR:Grabber: Mystery discovered 0 compatible devices.
Feb 07, 2018 22:32:13.942 [0x700010e94000] DEBUG - DVR:Recorder: It took 2.8 sec to start the session for http://192.168.1.195:5004/auto/v746
Feb 07, 2018 22:32:17.863 [0x700010e94000] DEBUG - DVR:Recorder: It took 3.9 sec to start the session for http://192.168.1.195:5004/auto/v746
Feb 07, 2018 22:39:29.956 [0x70000fa9f000] DEBUG - DVR:Device: Discovering and refreshing devices.
Feb 07, 2018 22:39:29.957 [0x70000fa9f000] DEBUG - DVR:Grabber: HDHomerun discovered 0 compatible devices.
Feb 07, 2018 22:39:29.957 [0x70000fa9f000] DEBUG - DVR:Device: Testing grabber HDHomerun device device://tv.plex.grabbers.hdhomerun/1327C935 at http://192.168.1.195:80
Feb 07, 2018 22:39:31.974 [0x70000fa9f000] DEBUG - DVR:Device: Device was alive, refreshed device://tv.plex.grabbers.hdhomerun/1327C935.
Feb 07, 2018 22:39:31.974 [0x70000fa9f000] DEBUG - DVR:Grabber: Mystery discovered 0 compatible devices.
Feb 07, 2018 22:39:35.716 [0x7000105e1000] DEBUG - DVR:Device: Discovering and refreshing devices.
Feb 07, 2018 22:39:35.717 [0x7000105e1000] DEBUG - DVR:Grabber: HDHomerun discovered a model HDHR3-CC.
Feb 07, 2018 22:39:35.723 [0x7000105e1000] DEBUG - DVR:Grabber: HDHomerun discovered 1 compatible devices.
Feb 07, 2018 22:39:35.723 [0x7000105e1000] DEBUG - DVR:Device: Testing grabber HDHomerun device device://tv.plex.grabbers.hdhomerun/1327C935 at http://192.168.1.195:80
Feb 07, 2018 22:39:35.731 [0x7000105e1000] DEBUG - DVR:Device: Device was alive, refreshed device://tv.plex.grabbers.hdhomerun/1327C935.
Feb 07, 2018 22:39:35.731 [0x7000105e1000] DEBUG - DVR:Grabber: Mystery discovered 0 compatible devices.
Feb 07, 2018 22:39:41.236 [0x7000112ac000] DEBUG - DVR:Recorder: Asked to stop recording ‘Witness (1985)’.
Feb 07, 2018 22:39:41.237 [0x7000112ac000] DEBUG - DVR:Recorder: Stopping transcode session.
Feb 07, 2018 22:39:41.237 [0x7000112ac000] DEBUG - DVR:Grabber: Freed a tuner (now 3 available)
Feb 07, 2018 22:39:41.237 [0x7000112ac000] DEBUG - DVR:Grabber: Recording for ‘Witness (1985)’ stopped with status complete.
Feb 07, 2018 22:39:41.237 [0x7000112ac000] DEBUG - DVR:Grabber: Using recording status.
Feb 07, 2018 22:39:41.237 [0x7000112ac000] DEBUG - DVR:Grabber: Scheduling ‘Witness (1985)’ for assimilation.
Feb 07, 2018 22:39:41.313 [0x700010d8e000] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.tms://movie/MV000186450000 thumb: http://tmsimg.plex.tv/assets/p8671_v_v5_aa.jpg title: Witness type: 1 year: 1985’ to library item
Feb 07, 2018 22:39:41.313 [0x700010d8e000] DEBUG - DVR:Grabber: Postprocessing, we’re going to put Witness (1985) in /Volumes/Media_Alpha/Movies/Witness (1985)/Witness (1985).ts
Feb 07, 2018 22:39:41.378 [0x700010d8e000] DEBUG - DVR:Grabber: Moving /Volumes/Media_Alpha/Movies/.grab/f94b8c7aaeff59d14e6ec74a153bc27c3b55fa54/Witness (1985).ts to /Volumes/Media_Alpha/Movies/Witness (1985)/Witness (1985).ts
Feb 07, 2018 22:39:41.405 [0x700010d8e000] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.tms://movie/MV000186450000 thumb: http://tmsimg.plex.tv/assets/p8671_v_v5_aa.jpg title: Witness type: 1 year: 1985’ to library item
Feb 07, 2018 22:39:42.127 [0x700010f9a000] DEBUG - DVR:Recorder: Asked to stop recording ‘Witness (1985)’.

2

Could you please provide the full set of zipped logs as you get from Download Logs web interface

is the problem reproducible ?

Could you get directory listing of the files below /Volumes/Media_Alpha/Movies/.grab/ whilst recording to see what file sizes the temp files reach and also at the end similar listings of the target directories, eg Volumes/Media_Alpha/Movies/Witness (1985)/

and together with full logs

It was supposed to record 6171 seconds (approx 1 hour 43 seconds) but appears to have completed it after about 7 minutes

3

I’ll try again and see what happens. It’s recorded other items fine. The last three movies did the same thing. Witness was the first.

How do you want the logs? Attach here?

4

Yes please plus the other info requested

5

@captriker said:
I’ll try again and see what happens. It’s recorded other items fine. The last three movies did the same thing. Witness was the first.

How do you want the logs? Attach here?

Just drag the Plex generated zip file right into the message and that will upload it for you.

6

@captriker did you every solve this problem?