Server Version#: 1.26.0.5715
Tuner Make/Model: HDHomerun HDHR5-4DT
Guide/Lineup name: BT TV
Using XMLTV?: No
My recordings keep randomly only recording a few minutes, the can be anywhere from 3 to 11 minutes . The recordings show as complete in the DVR schedule but the recording ‘media info’ shows Partial recording reason: The recording was cancelled.
Can anyone help?
I’m seeing the same issue, only my recordings are all two minutes or less. Every episode of every recording in my DVR has this issue. I’ve only noticed this since the last update.
Version 1.26.0.5715
Tuner HDHomeRun FLEX 4K
Guide name PMB-Server
Using XMLTV No
Correction. I’m manually reviewing every file on the DVR server drive and I’ve found one episode of Family Feud that’s 2:17.
@sa2000, can you help? I’ve seen a few posts similar but with no resolution?
Just adding a comment here to try bump this issue.
I am having the exact same experience at the moment.
Need the logs covering the time of failure in order to see what is happening.
Here are the logs I downloaded from the server app. Not sure how/what to do with them.
Plex Media Server Logs_2022-05-09_11-40-23.zip (4.7 MB)
I was comparing your logs to what I’m getting and noticed at 1:19 am today the transcoder stats 4 shows ‘mediaGrabError="Recording failed. Please check your tuner or antenna’. I think I’ve seen this before on another thread that said to check your signal strength.
@sk8brder100 - Can you verify that your network and internet connectivity is stable? In the logs you posted the oldest log only goes back to 5/8 at 17:40, and from then until 5/9 at 08:44 there are a lot of Internet disconnects being noted in the logs, with connection reestablished ~15 seconds later.
May 08, 2022 17:40:53.521 [0x30a025000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] MyPlex: We appear to have lost Internet connectivity, resetting device URL cache.
May 08, 2022 17:40:53.521 [0x30a025000] ERROR - [EventSourceClient/pubsub/139.162.219.82:443] Retrying in 15 seconds.
May 08, 2022 17:40:53.521 [0x309fa2000] ERROR - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Retrying in 15 seconds.
May 08, 2022 17:41:01.697 [0x309e97000] DEBUG - EPG[cloud]: Next thing to start/end is at 2022-05-08 16:45:00 GMT (in 240 seconds)
May 08, 2022 17:41:08.525 [0x309fa2000] DEBUG - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Resolving 81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct port 7443
May 08, 2022 17:41:08.525 [0x30a025000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] Resolving 139.162.219.82 port 443
May 08, 2022 17:41:08.833 [0x30a025000] DEBUG - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Resolved 81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct to 81.174.155.220:7443
May 08, 2022 17:41:08.833 [0x309fa2000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] Resolved 139.162.219.82 to 139.162.219.82:443
May 08, 2022 17:41:08.946 [0x30a025000] DEBUG - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Connected in 113 ms.
May 08, 2022 17:41:08.947 [0x30a025000] ERROR - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] [HttpHeader] invalid 'X-Plex-Device-Name' header value (James’s Mac mini)
May 08, 2022 17:41:08.947 [0x30a025000] DEBUG - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Wrote data, reading reply.
May 08, 2022 17:41:08.955 [0x309fa2000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] Connected in 121 ms.
May 08, 2022 17:41:08.955 [0x309fa2000] ERROR - [EventSourceClient/pubsub/139.162.219.82:443] [HttpHeader] invalid 'X-Plex-Device-Name' header value (James’s Mac mini)
May 08, 2022 17:41:08.955 [0x309fa2000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] Wrote data, reading reply.
May 08, 2022 17:41:09.119 [0x309fa2000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] Read HTTP reply header.
May 08, 2022 17:41:09.119 [0x30a025000] DEBUG - [EventSourceClient/mediaserver/81-174-155-220.4b54afae4d2142d8b5dd014cfc995a52.plex.direct:7443] Read HTTP reply header.
May 08, 2022 17:41:09.119 [0x309fa2000] DEBUG - [EventSourceClient/pubsub/139.162.219.82:443] MyPlex: We appear to have regained Internet connectivity.
From when it starts it appears to happen about every 17 minutes: Internet connection lost, then regained.
Specifically for when the Formula 1 recording today failed, Plex was informed of a network change but nothing changed, then it stopped recording. It does see that your device at 192.168.1.118 departed. Is this device a network Access Point?
May 09, 2022 00:51:13.221 [0x30a0a8000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.221 [0x30a0a8000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.222 [0x30a231000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.223 [0x30a231000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.223 [0x309f1a000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.223 [0x309f1a000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.234 [0x30a74f000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.235 [0x30a74f000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.236 [0x30a95b000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.236 [0x30a95b000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.237 [0x309bfd000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.238 [0x309bfd000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.263 [0x309b7a000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.263 [0x309b7a000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.351 [0x309e97000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.352 [0x309e97000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:13.387 [0x30a1ae000] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 09, 2022 00:51:13.387 [0x30a1ae000] DEBUG - Network change notification but nothing changed.
May 09, 2022 00:51:14.057 [0x30a2b4000] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 949.648185 seconds: 192.168.1.118 (RBR20 (AP))
May 09, 2022 00:51:14.057 [0x30a2b4000] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 949.648204 seconds: 192.168.1.118 (WANDevice)
May 09, 2022 00:51:14.057 [0x30a2b4000] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 949.648202 seconds: 192.168.1.118 (WANConnectionDevice)
May 09, 2022 00:51:14.876 [0x309e14000] DEBUG - Jobs: '/Applications/Plex Media Server.app/Contents/MacOS/Plex Transcoder' exit code for process 2936 is 0 (success)
May 09, 2022 00:51:14.876 [0x30a43d000] DEBUG - [Grabber/1a1f1e97c5236ba39803bc4030a28a0892569fed] Recorder: No more consumers, stopping.
May 09, 2022 00:51:14.876 [0x30a43d000] DEBUG - [Grabber/1a1f1e97c5236ba39803bc4030a28a0892569fed] Recorder: Asked to stop recording 'Formula 1 - Miami Grand Prix: Highlights' on channel 5fc76dc23f000e002d0cb613-5fc70603088e7d002d4c73a1.
May 09, 2022 00:51:14.876 [0x30a43d000] DEBUG - [Grabber/1a1f1e97c5236ba39803bc4030a28a0892569fed] Recorder: Stopping transcode session.
May 09, 2022 00:51:14.876 [0x30a337000] DEBUG - [Grabber/1a1f1e97c5236ba39803bc4030a28a0892569fed] Recording for 'Formula 1 - Miami Grand Prix: Highlights' on channel 5fc76dc23f000e002d0cb613-5fc70603088e7d002d4c73a1 stopped with status complete.
Edit: I had a case where a mesh node that was dropping packets, and I had my HDHR tuner connected to it. It wasn’t very noticable when web surfing, but was causing recording failures. I switched it to an AP and that node has been rock solid and no more recording failures. They may have fixed that mesh problem in a firmware upgrade, but I’m not switching back!
Under the logs settings you will want to disable the VERBOSE.
Plex was designed to be constantly running and your server is going to sleep which will cause recordings to fail/not occur.
In addition to looking at the network, you may want to clean out the EPG and refresh by shutting plex down and deleting the 3 tv.plex.providers.* files.
Hey, thanks. Yes, my tuner is connected to a mesh access point. The router setup is in AP mode though? I’ve not rebooted the router in a while though so I’ll do that and see what happens. Which file did you find the network issues in so I can check later?
Thanks for the support, I don’t have verbose enabled?
what are the provider files called? I’ve searched for tv.plex.providers and can’t find anything?
All of the log snippets I posted above are from the “Plex Media Server.log” files. Note that Plex rolls logs using a format of “Plex Media Server.(number).log”, so “Plex Media Server.1.log” will be the most recently rolled log, “Plex Media Server.2.log” the next, etc.
To find the tv.plex.provider files, start in your Plex Data Directory. For MacOS this is:
~/Library/Application Support/Plex Media Server/
then look for a subfolder there named ‘Plug-In Support/Databases’. Make sure you stop your Plex server service before deleting these EPG databases.
I think @pl_5309 was targeting RangerDoc275 regarding verbose logging…
Thanks, I’ll keep an eye on it over the next day or two.
I don’t have a ‘Plex Media Server’ folder in application files and can’t find a ‘Plug-in support/database’ folder anywhere?
Update: I’ve found the folder, it was hidden
Any updates on a resolution for this issue?
I’m so nearly done with Plex. In this state it’s useless for me. I purchased a lifetime Plex Pass last year and still we don’t have audio with ATSC 3.0 and then a few weeks ago this starts.
Is anyone at Plex actually looking into this or are we just a few users complaining about it without any Plex staff doing anything?
Has anyone from Plex evaluated Plex updates against Windows updates? Could that be what’s caused this?
With the literal $1000+ I’ve invested in a server, Windows OS, HD Homerun, and Plex Pass, not being able to do the most basic of things makes me want to trash the whole system and go on a cancel mission through social media.
Turn off your firewall.
@pl_5309 why would I want to run a server without a firewall? This thing ran fine for 6 or 7 months with the firewall on. I’ll try this for a couple days to see if indeed that helps but this is not a safe solution for anyone.
I just took a few minutes to look, to no avail, so I’ll ask you, are there Plex official instructions for configuring one’s firewall without turning it completely off?
Again, just seems like an odd suggestion given that this was not an issue for several months. Which makes me wonder again what conflicts may have arisen between Windows and Plex updates.
Thanks.
@pl_5309 per an earlier request, I turned off verbose a week or so back. Attached are current logs since then.
Also, I’m not sure if the comment was directed at me, but I have Windows Power set up to Never sleep, Never hibernate and to Never turn off HDDs. So the server going to sleep is not an issue.
As stated a few moments ago, this thing ran perfectly for months and only recently started this. And I have made no changes to Plex nor Windows other than updates.
Thanks again.
@pl_5309 I just went in to turn off the firewall temporarily. I then took a moment to look at what programs are already set up with permissions through the firewall. There’s already about 10 total programs between HD Homerun and Plex that were set up by default.
So again, I ask is this really a solution?
Thanks.
Turning off the firewall was temporary to see if the tcp errors went away, they did. Easiest way for Plex to re-apply the firewall rules is to uninstall followed by an install. There is a 1.26.2 beta version that fixes most of the date problems in 1.26.0 so it would be a good idea to grab it for the install.
There are two settings for verbose debug, one is for the player and the other for the server. Once you go into settings scroll down on the left column till you see General with Remote Access underneath. Click on General, that is the check box for turning off verbose for the server.
Drop another set of logs once you get verbose turned off and have some playback failures.
