I’m having this issue for some time now. My server is on a WIndows 7 PC, using HDHomerun, everything s wired, no wifi. Some scheduled recordings are missed, here is the log when it happens (192.168.2.15 is my hdhomerun) :
Nov 01, 2018 18:30:44.139 [6932] DEBUG - DVR:Grabber: Saving recording to “D:\Serie.grab\f6c4cb197b74e41a3b0517d9dbc726c1064a4e6b”
Nov 01, 2018 18:30:44.139 [6932] DEBUG - HTTP requesting GET http://192.168.2.15:80/lineup.json
Nov 01, 2018 18:30:44.154 [6932] DEBUG - HTTP 200 response from GET http://192.168.2.15:80/lineup.json
Nov 01, 2018 18:30:44.154 [6932] DEBUG - DVR:Grabber: Going to record for 1756 seconds, final URL is http://192.168.2.15:5004/auto/v35.1
Nov 01, 2018 18:30:44.154 [6932] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-01 19:00:00
Nov 01, 2018 18:30:44.154 [6932] DEBUG - DVR:Grabber: Waiting for a tuner (1 available).
Nov 01, 2018 18:30:44.154 [6932] DEBUG - DVR:Grabber: Allocated a tuner (0 left)
Nov 01, 2018 18:30:44.154 [6932] ERROR - DVR:Recorder: Error 3 (The recording was aborted) starting the record, shutting things down.
Nov 01, 2018 18:30:44.154 [6932] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-01 18:30:44
Nov 01, 2018 18:30:44.154 [6932] DEBUG - DVR:Grabber: Freed a tuner (now 1 available)
Nov 01, 2018 18:30:44.154 [4988] DEBUG - DVR:Schedule: Attempting to schedule the item ‘La facture - E9 - Episode 9’.
Nov 01, 2018 18:30:44.154 [6932] ERROR - DVR:Recorder: Error 3 (The recording was aborted) starting the record, shutting things down.
Nov 01, 2018 18:30:44.154 [4988] DEBUG - DVR:Schedule: Trying airing at 2018-11-06 19:30:00 on channel 602.
Nov 01, 2018 18:30:44.154 [6932] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-01 18:30:44
Nov 01, 2018 18:30:44.170 [6932] DEBUG - DVR:Grabber: Operation for Occupation double - E25 - Episode 25 completed with status error (The recording was aborted)
Nov 01, 2018 18:30:44.170 [4988] DEBUG - DVR:Schedule: Device 0 tuner 0 scheduled recording between 2018-11-06 19:30:00 and 2018-11-06 20:00:00 on channel 602.
Nov 01, 2018 18:30:44.170 [6932] DEBUG - Activity: Ended activity 32c4867e-9481-458c-bb7d-8bb203f41532.
Anybody have an idea ? Here’s another log from today failed recording. It seems to happen only when watching live TV. My hdhomerun has 2 tuner, this should not be an issue
Nov 13, 2018 18:30:00.017 [2760] DEBUG - Auth: authenticated user 1 as mbcollin
Nov 13, 2018 18:30:00.018 [3196] DEBUG - Request: [192.168.2.10:45445 (Subnet)] GET /livetv/sessions/1b594ec5-4078-458a-bdb1-c12614fa857f/b1ce5b763ec6a013-com-plexapp-android/index.m3u8?offset=-1.000000 (9 live) TLS Signed-in Token (mbcollin)
Nov 13, 2018 18:30:00.020 [3196] DEBUG - buildLiveM3U8: min 0 max 5100 ended 0
Nov 13, 2018 18:30:00.059 [2760] DEBUG - Completed: [192.168.2.10:45445] 200 GET /livetv/sessions/1b594ec5-4078-458a-bdb1-c12614fa857f/b1ce5b763ec6a013-com-plexapp-android/index.m3u8?offset=-1.000000 (9 live) TLS 41ms 173783 bytes (pipelined: 4698)
Nov 13, 2018 18:30:00.078 [3396] DEBUG - Request: [192.168.2.10:45444 (Subnet)] GET /livetv/sessions/1b594ec5-4078-458a-bdb1-c12614fa857f/b1ce5b763ec6a013-com-plexapp-android/05100.ts (9 live) TLS Signed-in
Nov 13, 2018 18:30:00.080 [3396] DEBUG - Content-Length of C:\transcode\Transcode\Sessions\plex-transcode-1b594ec5-4078-458a-bdb1-c12614fa857f\media-05100.ts is 2519012.
Nov 13, 2018 18:30:00.105 [3060] DEBUG - DVR:Grabber: Starting operation for ‘Occupation double - E33 - OD: la quotidienne’.
Nov 13, 2018 18:30:00.107 [3060] DEBUG - Activity: registered new activity 39e827fc-4350-4d35-8012-feb5f1cfb44f - Recording
Nov 13, 2018 18:30:00.108 [3060] DEBUG - DVR:Grabber: HDHomerun starting a media grab on device device://tv.plex.grabbers.hdhomerun/104DE8A1 (Silicondust HDHomeRun CONNECT, supported) tuner 1.
Nov 13, 2018 18:30:00.114 [3060] DEBUG - DVR:Subscription: Failed to resolve subscription for show ‘guid: com.gracenote.onconnect://show/455520 thumb: https://tmsimg.plex.tv/assets/p455520_b_v5_aa.jpg title: Occupation double type: 2 year: 2003’ to library item
Nov 13, 2018 18:30:00.116 [3060] DEBUG - DVR:Grabber: Saving recording to “D:\Serie.grab\94cd623580e0f25f8b110da537122120de55c83f”
Nov 13, 2018 18:30:00.117 [3060] DEBUG - HTTP requesting GET http://192.168.2.15:80/lineup.json
Nov 13, 2018 18:30:00.142 [3060] DEBUG - HTTP 200 response from GET http://192.168.2.15:80/lineup.json
Nov 13, 2018 18:30:00.143 [3060] DEBUG - DVR:Grabber: Going to record for 1800 seconds, final URL is http://192.168.2.15:5004/auto/v35.1
Nov 13, 2018 18:30:00.145 [3060] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-13 19:00:00
Nov 13, 2018 18:30:00.145 [3060] DEBUG - DVR:Grabber: Waiting for a tuner (1 available).
Nov 13, 2018 18:30:00.146 [3060] DEBUG - DVR:Grabber: Allocated a tuner (0 left)
Nov 13, 2018 18:30:00.146 [3060] ERROR - DVR:Recorder: Error 3 (The recording was aborted) starting the record, shutting things down.
Nov 13, 2018 18:30:00.146 [3060] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-13 18:30:00
Nov 13, 2018 18:30:00.146 [3060] DEBUG - DVR:Grabber: Freed a tuner (now 1 available)
Nov 13, 2018 18:30:00.147 [3060] ERROR - DVR:Recorder: Error 3 (The recording was aborted) starting the record, shutting things down.
Nov 13, 2018 18:30:00.147 [3060] DEBUG - MediaRecorderVirtual: setting stop time to 2018-11-13 18:30:00
Nov 13, 2018 18:30:00.147 [3060] DEBUG - DVR:Grabber: Operation for Occupation double - E33 - OD: la quotidienne completed with status error (The recording was aborted)
Nov 13, 2018 18:30:00.147 [3060] DEBUG - Activity: Ended activity 39e827fc-4350-4d35-8012-feb5f1cfb44f.
Nov 13, 2018 18:30:00.148 [3060] ERROR - DVR:Grabber: Starting media grab failed.
Nov 13, 2018 18:30:00.236 [2768] DEBUG - Completed: [192.168.2.10:45444] 200 GET /livetv/sessions/1b594ec5-4078-458a-bdb1-c12614fa857f/b1ce5b763ec6a013-com-plexapp-android/05100.ts (9 live) TLS 158ms 2519012 bytes (pipelined: 2515)
Nov 13, 2018 18:30:00.475 [5444] DEBUG - Transcoder segment range: 0 - 5101
Nov 13, 2018 18:30:01.151 [2768] DEBUG - Auth: authenticated user 1 as mbcollin
