DVR aborting all recordings

General Discussions Plex Features
1

I’ve been tinkering w/ the DVR off and on for quite a while now, over several versions. I somehow recorded a show early on in the beta life cycle but have not been able to successfully record a show since. I was so jazzed about the DVR and thought I could finally dump my legacy TiVo.

Would really appreciate any assistance from Plex support here.

Setup: I’ve updated to the latest versions: Web - 3.2.1, Server - 1.5.6.3790. I’m using an HDHomeRun Extend. Program guide successfully loads. Plenty of drive space available in recordings library folder.

Problem: scheduled recordings abort almost immediately. Turned on logging, didn’t see anything obvious, but I may be missing the less obvious. At the very least, nothing in the log mentioning show titles for those I’ve tried.

2

Not Plex Support so not sure why you are seeing these aborts but wanted to point out you are on the latest Public version but not on the latest Plex Pass version. Current Plex Pass version is 1.7.2.3878. You may want to turn on the Plex Pass downloads option to get the current Plex Pass version.

ou7junon2brt.jpg552×640 53.6 KB

3

Thanks @johnm_ColaSC I went and got the proper version and installed. My server versioning strategy has been less than consistent. Most recent updated was from w/in the Server Settings page, which may not have known to pull the latest Plex Pass version instead of the current public version.

So, I’ve done that; downloaded, installed 1.7.2.3878, rebooted and tried to record a currently airing show. Still a no-go, but w/ a slightly different message; “An unknown error occurred” instead of “this recording was aborted”.

4

May need to post logs and hope a Plex Employee or Plex Ninja can decipher the logs. I will look but can’t guarantee I will be able to determine what the issue might be.

First make sure in your Settings you are not including the token in your logs. Settings/Server then click Show Advanced if it is not already displaying advanced settings.

5j10s1oqdv23.png910×99 81.8 KB

If the setting is selected as the text below the option states you will need to restart the server.

To download logs go to Settings/Server/Help and then click the Download Logs button. Upload the zip file to this thread.

d9pg0302zniw.png835×212 99.1 KB

5

Thanks again @johnm_ColaSC .

Plex official support, or savvy Plex gurus, I would greatly appreciate any assistance on diagnosing my DVR recording issues. Logs attached.

6

Hopefully someone from Plex will chime in here. I did look through the log a little and found the below:

Jun 08, 2017 12:30:00.188 [8992] DEBUG - DVR:Grabber: Starting operation for ‘The Best of the Joy of Painting - E1 - Gray Mountain’.
Jun 08, 2017 12:30:00.188 [8992] DEBUG - Activity: registered new activity dd7e1158-b113-4228-bf16-128a171cb4de - Recording
Jun 08, 2017 12:30:00.188 [8992] DEBUG - DVR:Grabber: HDHomerun starting a media grab on device device://tv.plex.grabbers.hdhomerun/1054E25D tuner 0.
Jun 08, 2017 12:30:00.195 [8992] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.onconnect://show/339998 thumb: http://tmsimg.plex.tv/assets/p339998_b_v5_ac.jpg title: The Best of the Joy of Painting type: 2 year: 1991’ to library item
Jun 08, 2017 12:30:00.197 [8992] DEBUG - DVR:Grabber: Saving recording to C:\Data\TVShows2.grab\e33432ee8d37f598f018a34a8b04de5b77b58827
Jun 08, 2017 12:30:00.198 [8992] DEBUG - DVR:Grabber: Going to record for 1800 seconds, final URL is http://192.168.1.2:5004/auto/v25.4?transcode=heavy
Jun 08, 2017 12:30:00.199 [8992] DEBUG - DVR:Grabber: Setting timer to stop grab of ‘The Best of the Joy of Painting - E1 - Gray Mountain’ in 1800 seconds.
Jun 08, 2017 12:30:00.200 [8992] DEBUG - DVR:Segmenter: Creating a new recorder for http://192.168.1.2:5004/auto/v25.4?transcode=heavy.
Jun 08, 2017 12:30:00.204 [8992] DEBUG - DVR:Grabber: Waiting for a tuner (2 available).
Jun 08, 2017 12:30:00.205 [8992] DEBUG - DVR:Grabber: Allocated a tuner (1 left)
Jun 08, 2017 12:30:00.206 [8992] DEBUG - We’re going to try to auto-select an audio stream for account 1.
Jun 08, 2017 12:30:00.206 [8992] DEBUG - Selecting best audio stream for part ID -1 (autoselect: 0 language: en)
Jun 08, 2017 12:30:00.206 [8992] DEBUG - Falling back to picking the first audio stream 1.
Jun 08, 2017 12:30:00.206 [8992] DEBUG - We’re going to try to auto-select a subtitle.
Jun 08, 2017 12:30:00.206 [8992] DEBUG - Audio Stream: -1, Subtitle Stream: -1
Jun 08, 2017 12:30:00.207 [8992] ERROR - Unable to find title for item of type 5
Jun 08, 2017 12:30:00.207 [8992] DEBUG - MDE: analyzing media item -1
Jun 08, 2017 12:30:00.207 [8992] DEBUG - MDE: : no direct play video profile exists for http/mpegts/
Jun 08, 2017 12:30:00.208 [8992] DEBUG - MDE: : no direct play video profile exists for http/mpegts//
Jun 08, 2017 12:30:00.208 [8992] DEBUG - MDE: : codec is unavailable for analysis
Jun 08, 2017 12:30:00.208 [8992] DEBUG - MDE: : codec is unavailable for analysis
Jun 08, 2017 12:30:00.208 [8992] ERROR - Unable to find title for item of type 5
Jun 08, 2017 12:30:00.208 [8992] DEBUG - MDE: : selected media 0 / -1
Jun 08, 2017 12:30:00.209 [8992] DEBUG - Cleaning directory for session 34c0703b-370a-43fd-9033-815376ccbb01 ()
Jun 08, 2017 12:30:00.209 [8992] DEBUG - Starting a transcode session 34c0703b-370a-43fd-9033-815376ccbb01 at offset -1.0 (state=3)
Jun 08, 2017 12:30:00.210 [8992] DEBUG - Streaming Resource: Added session 04C4B060:34c0703b-370a-43fd-9033-815376ccbb01
Jun 08, 2017 12:30:00.215 [8992] DEBUG - Job running: EAE_ROOT=’\?\C:\Users\Mike\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\EasyAudioEncoder’ FFMPEG_EXTERNAL_LIBS=’\\?\C:\Users\Mike\AppData\Local\Plex\ Media\ Server\Codecs\18f9bcf-1233-windows-i386\’ XDG_CACHE_HOME=‘C:\Users\Mike\AppData\Local\Plex Media Server\Cache’ XDG_DATA_HOME=‘C:\Program Files (x86)\Plex\Plex Media Server\Resources’ X_PLEX_TOKEN=‘xxxxxxxxxxxxxxxxxxxx’ C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe -noaccurate_seek -ignore_unknown -scan_all_pmts -1 -i http://192.168.1.2:5004/auto/v25.4?transcode=heavy -map 0:V? -codec:V copy -map 0:a? -codec:a copy -copypriorss:a 0 -map 0:s? -codec:s copy -segment_format mpegts -f ssegment -individual_header_trailer 0 -segment_time 1 -segment_start_number 0 -segment_copyts 1 -segment_time_delta 0.0625 -segment_list http://127.0.0.1:32400/video/:/transcode/session/34c0703b-370a-43fd-9033-815376ccbb01/1bacb5db-8a4e-4deb-824d-6ef8924b8881/seglist -segment_list_type csv -segment_list_size 2147483647 -max_delay 5000000 -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 media-%05d.ts -start_at_zero -copyts -vsync cfr -y -nostats -loglevel quiet -loglevel_plex error -progressurl http://127.0.0.1:32400/video/:/transcode/session/34c0703b-370a-43fd-9033-815376ccbb01/1bacb5db-8a4e-4deb-824d-6ef8924b8881/progress
Jun 08, 2017 12:30:01.138 [3844] DEBUG - EPG[onconnect]: Next thing to start/end is at 2017-06-08 17:00:00 (in 1800 seconds)
Jun 08, 2017 12:30:05.530 [7736] ERROR - [Transcoder] http://192.168.1.2:5004/auto/v25.4?transcode=heavy: Server returned 5XX Server Error reply
Jun 08, 2017 12:30:05.545 [5144] DEBUG - Jobs: ‘C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe’ exit code for process 8528 is 1
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Using default transcode duration of 120 minutes
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Started session successfully: 34c0703b-370a-43fd-9033-815376ccbb01
Jun 08, 2017 12:30:05.545 [8992] DEBUG - DVR:Recorder: It took 5.3 sec to start the session for http://192.168.1.2:5004/auto/v25.4?transcode=heavy
Jun 08, 2017 12:30:05.545 [8992] ERROR - Unable to find title for item of type 5
Jun 08, 2017 12:30:05.545 [8992] DEBUG - MDE: analyzing media item -1
Jun 08, 2017 12:30:05.545 [8992] ERROR - MDE: video has neither a video stream nor an audio stream
Jun 08, 2017 12:30:05.545 [8992] DEBUG - MDE: ignoring media item -1
Jun 08, 2017 12:30:05.545 [8992] ERROR - MDE: no compatible media decisions are available
Jun 08, 2017 12:30:05.545 [8992] ERROR - DVR:Recorder: Unable to compute media decision.
Jun 08, 2017 12:30:05.545 [8992] ERROR - DVR:Recorder: Error 14 starting the record, shutting things down.
Jun 08, 2017 12:30:05.545 [8992] DEBUG - DVR:Recorder: Asked to stop recording ‘The Best of the Joy of Painting - E1 - Gray Mountain’.
Jun 08, 2017 12:30:05.545 [8992] DEBUG - DVR:Recorder: Stopping transcode session.
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Killing job.
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Job was already killed, not killing again.
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Stopping transcode session 34c0703b-370a-43fd-9033-815376ccbb01
Jun 08, 2017 12:30:05.545 [8992] DEBUG - DVR:Grabber: Freed a tuner (now 2 available)
Jun 08, 2017 12:30:05.545 [8992] DEBUG - DVR:Grabber: Operation for The Best of the Joy of Painting - E1 - Gray Mountain completed with status error (An unknown error occurred)
Jun 08, 2017 12:30:05.545 [8992] DEBUG - Activity: Ended activity dd7e1158-b113-4228-bf16-128a171cb4de.
Jun 08, 2017 12:30:05.545 [8992] ERROR - DVR:Grabber: Starting media grab failed.’

Looks like a record attempted to start at 12:30 “The Best of the Joy of Painting - E1 - Gray Mountain.” It then ended 5 seconds later when a 5XX error was returned from server which should be the HDHR.
What HDHR device do you have? Have you tried other Transcode settings? I would suggest turning off the Transcode setting in Plex and see if you can record something.

7

I have the HDHR EXTEND. I think you are onto something @johnm_ColaSC My EXTEND is supposed to handle the transcoding prior to hitting Plex server. But, I don’t see how to turn off the transcoder in Plex, only change its quality, timeout, duration and speed. I currently have the defaults set:

Transcoder quality = Automatic
Segmented transcoder timeout = 20
Transcoder default duration = 120
Transcoder default throttle buffer = 60
Background transcoding x264 preset = very fast
Maximum simultaneous video transcode = Unlimited

8

I don’t have an Extend so have no idea about how it should be configured in Plex. Have you searched the forum for other Extend related posts?

9

Yes, and what I found here; https://support.plex.tv/hc/en-us/articles/225877347-DVR-Beta-
says to set the DVR specific transcoder to Highest quality, which is how mine is set.

I thought I was doing myself a favor by going for the EXTEND.

10

Do you have any settings on the Extend set to Transcode? If so have you tried the Original Quality setting. If the Extend is transcoding to h264 and you have Plex set to Highest Quality would that cause a problem? Perhaps a Plex Employee @keithah can comment on this issue.

11

first time going into the HDHomeRun EXTEND config. Looks like the Transcode profile is currently set to Mobile w/ alternate options for None, Heavy, Internet540, Internet 480, Internet360 and Internet240

12

Sorry I was meaning Original Quality in your Plex settings. That way Plex would hopefully take the stream it receives from the Extend.

13

Also, looking at the HDHR logs, I see lots of “rejecting request from 192.168.1.102 - no video data”, where .102 is my media server PC

14

Digging around on the SiliconDust forums I found this;

“If you have any type of remote access software on the PC such as TeamViewer, VNC, Remote Administrator, GoToMyPC, PCAnywhere, or LogMeIn, these programs may intercept the video data, breaking the protected path. Remove them.”

I’m using VNC Viewer remote into my HTPC as currently it doesn’t even have a monitor attached. So, now to see if there is anyway around that.

15

@lurambler Interesting, any luck? I’m using Google Remote Desktop, so may be a similar issue? Also, using “Hauppauge 1191 WinTV-HVR-955Q USB TV Tuner”. Would be nice to get some confirmation/acknowledgement from Plex Staff on this as I’ve been searching for days and have seen several dead-end threads. A simple acknowledgement would at least let us know its being investigated. :confused:

Jun 13, 2017 19:30:04.609 [10920] DEBUG - DVR:Recorder: It took 0.2 sec to start the session for http://127.0.0.1:32600/devices/dvb…(shortened-for-post)
Jun 13, 2017 19:30:04.609 [12376] INFO - Notification: Recording Family Feud - E36 - Episode 36 -
Jun 13, 2017 19:30:04.609 [10644] DEBUG - Jobs: ‘C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe’ exit code for process 16788 is 1
Jun 13, 2017 19:30:04.610 [10644] DEBUG - DVR:Grabber: Recording for ‘Family Feud - E36 - Episode 36’ stopped with status error.
Jun 13, 2017 19:30:04.610 [10644] DEBUG - DVR:Grabber: Scheduling ‘Family Feud - E36 - Episode 36’ for assimilation.
Jun 13, 2017 19:30:04.613 [5136] DEBUG - DVR:Subscription: Failed to resolve subscription for ‘guid: com.gracenote.onconnect://show/8314079 thumb: http://tmsimg.plex.tv/assets/p13175445_b_v5_aa.jpg title: Family Feud type: 2 year: 2010’ to library item
Jun 13, 2017 19:30:04.613 [5136] DEBUG - DVR:Grabber: Postprocessing, we’re going to put Family Feud - E36 - Episode 36 in C:\Plex\Family Feud (2010)\Season 18\Family Feud (2010) - S18E36 - Episode 36.mkv
Jun 13, 2017 19:30:04.615 [4092] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 13, 2017 19:30:04.615 [11232] INFO - Library section 1 (DVR) will be updated because of a change in C:\Plex\Family Feud (2010)

Link to the SiliconDust reference for anyone interested…
https://www.silicondust.com/support/troubleshooting/#hdcp-support-required-message

16

@lurambler said:
first time going into the HDHomeRun EXTEND config. Looks like the Transcode profile is currently set to Mobile w/ alternate options for None, Heavy, Internet540, Internet 480, Internet360 and Internet240

Hi, I also have an Extend and have been confused about what I should be setting it to - finding it confusing on both SiliconDust and Plex. Did you get anywhere? I ended up buying the Channels app on Apple TV 4 so I could get Live TV which seems to work ok. Through that UI, I was able to set the Trascode to “Heavy”. But when using Plex on IoS (iphone6S), I’m nearly always getting a message that the NAS is not sufficiently powered. (I have a QNAP TS453-A 8GB RAM, Intel Celeron 1.6GHz running PMS 1.7.3.3937). What I don’t understand is When is the Extend Transcoding and when is the NAS transcoding and is there some sweet spot of settings that is best. What did you end up doing? I am not sure what benefit I am getting from the Extend over the cheaper Connect. I am just trying to watch CBS Live and can see that the NAS is running at 98% CPU and the iOS app is often buffering

17

If I delete a DVR’d episode, every subsequent episode for a given show is aborted within a few minutes of starting. The only way I can get PMS to begin recording any episodes again is to either restart PMS or restart my server.