DVR recordings all stopping after exactly 12 minutes

Fairly new to DVR recordings but I have a HDHomeRun 4K Quadro w/ OTA antenna setup and have had the same config since Jan 1 2025.

All of a sudden the past few days ALL recordings are only 12 minutes in length exactly.

I tried adding the “stop recording 1 minute after airing” and now they’re 13 minutes exactly.

Some shows I’m trying to record (like Good Morning America) are 2 hours some days but I’m still hit w/ the 12 minute recordings.

I’m also experiencing an error sometimes when watching shows from other sources that usually happens at the 12 minute mark too where I’ll get “An error occurred while attempting to play this video. Please check your connection and try again.”

NOTE: I’ve turned on/off HEVC encoding to no avail, and turned off transcoding while recording for DVR to no change, also rebooted HD Home Run box, plex server, made sure I’m on latest versions, etc etc. I can’t figure out what’s going on here. Does anyone have any insight?

Continuing to struggle with this - not even sure what more I can do to troubleshoot but I certainly need some help here :frowning:

Upload the server logs.

Sounds like your temp and transcoder space are too small.

1 Like

Sure thing - attached are my logs.

I transcode to /tmp (RAM) with 128GB of RAM available, with less than a quarter of that normally used even when recording TV.

Plex Media Server Logs_2025-03-03_09-14-42.zip (1.7 MB)

You have a few issues to work through.

First would be DNS Rebinding protection being done on your router. It is interfering with you Cert and the clients.

The transcoder is failing so much that the logs are almost useless. Change to the Public version of Plex and if possible 1.41.4.9463 till they can work out the issues. You may have compromised codecs from the releases a couple of weeks ago. I didn’t see evidence of Hardware TPU requests because of all the other noise in the log but for stability make sure to disable any HEVC and Hardware transcoding options.

This storage path (/home/runner/_work/plex-media-server/plex-media-server/Library) is performing poorly. Check the OS for failing controller or hard drive.

Ok, I’ve changed to 1.41.4.9463 for now.
If I have these “compromised codecs” how can I verify that or fix that? This is the first I’ve heard of this issue so it’s certainly interesting to me to see more about that and ensure it’s fixed.

Regarding DNS Rebinding, I have a Ubiquiti UDM Pro, there’s no setting on those for DNS Rebinding protection, anything I can/should do here?

Lastly, the path for /home/runner/_work/plex-media-server/plex-media-server/Library should be inside the docker container itself, which is inside a btrfs .img file and stored on dual mirror NVMe drives, should be no issues w/ performance on that at all.

I’m going to re-try some recordings now and see what happens but let me know in the meantime if there’s anything else I can/should do?
EDIT: Also, THANK YOU!

Can’t help with the DVR problems, but to answer a couple of questions:

  1. Stop Plex Media Server.
  2. Navigate to the Plex Data Folder.
  3. Rename Codecs folder to Codecs.old.
  4. Restart Plex Media Server.

Plex Media Server will re-create the Codecs folder and download new codecs as needed.

If all goes well you can then delete the Codecs.old folder. If Plex Media Server cannot download the codec, you will see a “the necessary codec could not be downloaded” error.

Use a public DNS such as 1.1.1.1 (Cloudflare), 8.8.8.8 (Google), or 9.9.9.9 (Quad9).

Additional Info: https://support.plex.tv/articles/206225077-how-to-use-secure-server-connections/#toc-4

Ok I’ve re-created the codecs folder, it seems to be downloading them as-needed now.
Still having issues w/ live TV/DVR, no idea what is going on there. New log zip attached where the server has only been running for like 20 mins now instead. Maybe this will be more helpful? It still seems VERY noisy though…

Regarding DNS rebinding, I’m using AdGuard Home on 10.0.0.20/21 that uses DNS over TLS to CloudFlare and Quad9 already as upstream DoT providers to process DNS queries.
Plex Media Server Logs_2025-03-03_15-06-51.zip (469.2 KB)

The UDM Pro is going to be a problem with DNS without going down the rabbit hole of setting up another DNS server to allow rebinding for *.plex.direct domain.

Are you sure you have the logs set to debug level for the server? They just seem to cut off after about 30 minutes and don’t show info I would expect to see.

Stumped because unless you are running a post processing script or a emulated tuner what you have is not stable.

@CorneliousJD

Re-enable debug level server logs. Info level logs do not have enough information. Do not enable verbose logging, which adds too much info to the log files.

Then restart Plex Media Server (to log startup sequence), recreate the problem, and pull & post a set of log files.

SettingsServer_Name → General + Show Advanced

For what it’s worth, I’m NOT having an issue connecting securely to my Plex server at all locally. I get secure connections w/out issue. (At least nothing that I’m aware of currently).

I’m an idiot and only turned on Plex WEB debug logging. fixing that now and re-creating.

What’s so weird to me is that it worked fine for a month or so and only just recently really started acting up w/ the DVR recordings. HDHomeRun is stable and can watch the shows with >90% reception the whole time and then Plex fails to do whatever it’s supposed to, even w/ zero post-processing scripts happening.

Thanks for this, your screenshot made me realize I did plex web debug logging, not server debug, will have updated longs soon.

So my only change between last test and now has been enabling debug logging… and I’ve had two shows fully record now via DVR. So strange… Will continue to keep you guys posted, thanks for the help thus far, and in advance :wink:

Ok I guess I spoke too soon…

so Wheel of Fortune recorded just fine for a full 30 minutes, then Jeopardy right after it sat and showed it was recording for 30 minutes but resulting file is only 12 min long - same issue as the others.

Latest logs attached. Will reboot server again and continue to monitor overnight and into AM.
Plex Media Server Logs_2025-03-03_20-03-07.zip (3.8 MB)

You likely have your local network defined in Server Settings > Network > “List of IP addresses and networks that are allowed without auth”. Normally not needed but lets leave this alone or you may loose access to the server because of the Cert issue.

You have Hardware transcoding enabled but it is failing on the driver detect for [GPU] Got device: NVIDIA GP104GL [Tesla P4]. Means the CPU is doing all the processing for the DVR streams which might be having a problem.

CPU detect is only showing “Processor: 4-core Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz”, if accurate the container might be running out of capacity after 2 streams. There are times when the Grabber fails to start while 2 others are running. If you are limiting CPU’s in the Docker Run/Compose file you may want to remove that.

But the most likely cause of your issue is the bouncing network, especially if it occurs during the Grabber start up.

Mar 03, 2025 20:02:58.947 [23163045354296] DEBUG - NetworkInterface: Notified of network changed (force=0)
Mar 03, 2025 20:02:58.950 [23163045354296] DEBUG - Network change notification but nothing changed.
Mar 03, 2025 20:02:58.950 [23163045354296] DEBUG - NetworkInterface: received Netlink message len=1816, type=RTM_NEWLINK, flags=0x0
Mar 03, 2025 20:02:58.950 [23163045354296] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=8786, flags=0x1002, change=0x100
Mar 03, 2025 20:02:58.950 [23163045354296] DEBUG - Network change.
Mar 03, 2025 20:02:58.950 [23163045354296] DEBUG - NetworkInterface: Notified of network changed (force=0)
Mar 03, 2025 20:02:58.954 [23163045354296] DEBUG - Network change notification but nothing changed.
Mar 03, 2025 20:02:58.954 [23163045354296] DEBUG - NetworkInterface: received Netlink message len=440, type=RTM_NEWLINK, flags=0x0
Mar 03, 2025 20:02:58.954 [23163045354296] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=8786, flags=0x1002, change=0x0
Mar 03, 2025 20:02:58.954 [23163045354296] DEBUG - Network change.
Mar 03, 2025 20:02:58.954 [23163045354296] DEBUG - NetworkInterface: Notified of network changed (force=0)
Mar 03, 2025 20:02:58.958 [23163045354296] DEBUG - Network change notification but nothing changed.
Mar 03, 2025 20:02:58.958 [23163045354296] DEBUG - NetworkInterface: received Netlink message len=1816, type=RTM_NEWLINK, flags=0x0
Mar 03, 2025 20:02:58.958 [23163045354296] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=8786, flags=0x1003, change=0x1
Mar 03, 2025 20:02:58.958 [23163045354296] DEBUG - Network change.

Review your docker config for networking, Plex is seeing two network interfaces, so either the bond0 is failing or it confused by the bridge.

Network interfaces:
 * 1 lo (127.0.0.1) (00-00-00-00-00-00) (loopback: 1)
 * 11 bond0 (10.0.0.10) (0C-C4-7A-30-59-78) (loopback: 0)
 * 14 br-8fa7b5733806 (172.18.0.1) (02-42-39-E4-2C-72) (loopback: 0)
 * 1 lo (::1) (00-00-00-00-00-00) (loopback: 1)
Creating NetworkServices singleton.
1 Like

Understood, I’m going to leave this be for now since it’s not causing an issue w/ internal access due to the LAN setup.

I had set DVR to NOT transcode during recording, I just turned that on and told it to use hardware transcoding at 99 quality, although it doesn’t look like anything is actually coming out as smaller file sizes. Not an issue though, would rather have the GPU doing it than CPU anyways I guess.

THANK YOU - I forgot I setup CPU pinning on docker for Plex at one point because it kept going CRAZY on my CPU for things like credit/intro detections. I have a feeling this may have been a big part of my issue.

So this is how the unraid docker config just seems to be. I have it set to HOST mode for networking but it still has that 172.18.0.1 network address as the bridge for some reason.
I tried setting the preferred network interface to 10.0.0.10 but it doesn’t seem to have helped, I still see the “Network change notification but nothing changed.” in my logs right now.

If you think this is causing an issue I can certainly try setting a custom IP on that container instead of using host mode?

I’m currently running more tests now w/ CPU pinning disabled to see if that ends up fixing the problem or not, but in the meantime if you have insight on the network portion let mek now.

I don’t want to speak too soon but after removing that limit on the CPU to open up all 32 threads everything so far has been working that I’ve test-recorded now.

Still seeing those network issue logs in there but I do think that has been in there for literally 4+ years as my network config hasn’t changed from my docker host (unraid) and it being in “host” network mode.

Keeping my fingers crossed!

Quick update - so far so good, multiple recordings last night and this morning all working as they should. I think CPU pinning was crippling the server a bit too much…

I have confirmed w/ others who run Plex dockers on unraid under macvlan that they see a second networking interface as well, but I can change it to a custom IP instead and that would resolve the network oddities in the logs. I’ll keep that in mind as I move forward here too.

If I don’t end up coming back w/ further updates then if anyone finds this later in the future then assume this last post would mean that CPU pinning was the root cause of the issue by restricting resources too far.

Good to hear.

Unfortuantely, I am back. The issue has resurfaced again for some reason.

My next step is to change the IP to 10.0.0.15
I’m also able to get a 10-0-0-15-xxxxx.plex.drect address and connect other docker containers to it (for example, tautulli) so I think that’s working correctly now?

I’ll monitor and see what happens from here, as I did see some interesting logs as playback of a local file (not live TV or DVR this time) stopped right around the timestamp where there was some network things logged. (deubg logging was off for htis one)

Plex w/ a local file had the error at about 5:49PM or just prior and here are the logs from that time frame.

Mar 08, 2025 17:47:20.329 [22985347181368] WARN - [Req#22/Transcode] Got a transcode session ping without a valid session ID.
Mar 08, 2025 17:47:21.641 [22985112857400] INFO - Refreshing paths watched by LibraryUpdateManager
Mar 08, 2025 17:47:28.374 [22985121413944] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:28.382 [22985105759032] WARN - [Req#d9] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.383 [22985038515000] WARN - [Req#de] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.383 [22985101540152] WARN - [Req#db] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.383 [22985347181368] WARN - [Req#dd] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.383 [22985040624440] WARN - [Req#dc] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.383 [22985036405560] WARN - [Req#df] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:47:28.416 [22985063967544] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:28.418 [22985347181368] WARN - [Req#dd] SLOW QUERY: It took 280.000000 ms to retrieve 6 items.
Mar 08, 2025 17:47:28.427 [22985036405560] WARN - [Req#df] SLOW QUERY: It took 380.000000 ms to retrieve 11 items.
Mar 08, 2025 17:47:28.482 [22985040624440] WARN - [Req#dc] SLOW QUERY: It took 870.000000 ms to retrieve 39 items.
Mar 08, 2025 17:47:28.527 [22985101540152] WARN - [Req#db] SLOW QUERY: It took 1230.000000 ms to retrieve 19 items.
Mar 08, 2025 17:47:28.738 [22985357974328] WARN - [CERT] TLS connection from 10.0.0.10:40270 came in with unrecognized plex.direct SNI name '10-0-0-10.cf320e351cde457a9b1afd1acb1446dd.plex.direct'; using installed plex.direct cert
Mar 08, 2025 17:47:28.925 [22985134136120] WARN - [HttpClient/HCl#44] HTTP error requesting GET https://10-0-0-10.cf320e351cde457a9b1afd1acb1446dd.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '10-0-0-10.cf320e351cde457a9b1afd1acb1446dd.plex.direct')
Mar 08, 2025 17:47:29.372 [22985355864888] WARN - [CERT] TLS connection from 10.0.0.10:51168 came in with unrecognized plex.direct SNI name '172-18-0-1.0b583e932a864f3f98d4eb20ecfba74c.plex.direct'; using installed plex.direct cert
Mar 08, 2025 17:47:29.863 [22985134136120] WARN - [HttpClient/HCl#48] HTTP error requesting GET https://172-18-0-1.0b583e932a864f3f98d4eb20ecfba74c.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '172-18-0-1.0b583e932a864f3f98d4eb20ecfba74c.plex.direct')
Mar 08, 2025 17:47:29.950 [22985129851704] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:29.962 [22985072282424] WARN - [Req#110] Invalid library metadata ID plex://show/5fc69fafc2d465002df7bc29 passed.
Mar 08, 2025 17:47:29.963 [22985072282424] ERROR - downloadContainer: expected MediaContainer element, found html
Mar 08, 2025 17:47:29.963 [22985072282424] WARN - Subscription: No container available for /tv.plex.providers.epg.cloud:2/metadata/plex%3A%2F%2Fshow%2F5fc69fafc2d465002df7bc29
Mar 08, 2025 17:47:29.963 [22985072282424] ERROR - Subscription: Error refreshing sub: No container found
Mar 08, 2025 17:47:30.075 [22985362598712] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:30.687 [22985136245560] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:30.814 [22985061858104] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:35.089 [22985034296120] WARN - [Req#1f7] QueryParser: Invalid field 'libraryHubsOnly' found, ignoring.
Mar 08, 2025 17:47:35.457 [22985040624440] WARN - [Req#203] QueryParser: Invalid field 'libraryHubsOnly' found, ignoring.
Mar 08, 2025 17:47:37.677 [22985061858104] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:41.794 [22985061858104] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:46.634 [22985061858104] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:48.224 [22985061858104] ERROR - Unknown metadata type: 
Mar 08, 2025 17:47:50.325 [22985105759032] WARN - [Req#21b/Transcode] Got a transcode session ping without a valid session ID.
Mar 08, 2025 17:48:20.329 [22985101540152] WARN - [Req#252/Transcode] Got a transcode session ping without a valid session ID.
Mar 08, 2025 17:48:43.373 [22985105759032] WARN - [Req#272/Transcode] Got a request to stop a transcode session without a valid session GUID.
Mar 08, 2025 17:49:24.883 [22985105759032] WARN - [Req#2c5/Transcode] Got a request to stop a transcode session without a valid session GUID.
Mar 08, 2025 17:49:24.920 [22985105759032] WARN - [Req#2d1] QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Mar 08, 2025 17:49:24.920 [22985105759032] WARN - [Req#2d1] QueryParser: Invalid field 'libraryHubsOnly' found, ignoring.
Mar 08, 2025 17:49:24.920 [22985105759032] WARN - [Req#2d1] QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Mar 08, 2025 17:49:24.989 [22985129851704] WARN - [Req#2d7] QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Mar 08, 2025 17:49:24.989 [22985129851704] WARN - [Req#2d7] QueryParser: Invalid field 'libraryHubsOnly' found, ignoring.
Mar 08, 2025 17:49:24.989 [22985129851704] WARN - [Req#2d7] QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Mar 08, 2025 17:49:25.032 [22985105759032] WARN - [Req#2d1] SLOW QUERY: It took 300.000000 ms to retrieve 50 items.
Mar 08, 2025 17:49:25.359 [22985121590072] WARN - [Req#2ed] QueryParser: Invalid field 'libraryHubsOnly' found, ignoring.
Mar 08, 2025 17:49:32.927 [22985129851704] INFO - [Req#312/Transcode/1a21c65e5f1e35a8-com-plexapp-android] CodecManager: starting EAE at "/tmp/pms-b002e9f6-e115-45b5-b44b-67f0ffdde981/EasyAudioEncoder"
Mar 08, 2025 17:52:50.367 [22985105759032] INFO - [Req#84c] AutoUpdate: no updates available
Mar 08, 2025 17:57:40.225 [22985105759032] WARN - [Req#ea5] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.225 [22985347181368] WARN - [Req#ea7] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.227 [22985040624440] WARN - [Req#eab] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.227 [22985121590072] WARN - [Req#ea9] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.227 [22985129851704] WARN - [Req#eaa] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.231 [22985136245560] WARN - [Req#ea8] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 17:57:40.285 [22985136245560] WARN - [Req#ea8] SLOW QUERY: It took 280.000000 ms to retrieve 39 items.
Mar 08, 2025 17:57:40.286 [22985347181368] WARN - [Req#ea7] SLOW QUERY: It took 310.000000 ms to retrieve 19 items.
Mar 08, 2025 18:07:49.110 [22985036405560] WARN - [Req#1e11] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.111 [22985347181368] WARN - [Req#1e0f] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.112 [22985105759032] WARN - [Req#1e12] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.112 [22985040624440] WARN - [Req#1e13] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.116 [22985121590072] WARN - [Req#1e15] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.119 [22985038515000] WARN - [Req#1e14] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:07:49.168 [22985105759032] WARN - [Req#1e12] SLOW QUERY: It took 270.000000 ms to retrieve 39 items.
Mar 08, 2025 18:07:49.174 [22985036405560] WARN - [Req#1e11] SLOW QUERY: It took 300.000000 ms to retrieve 19 items.
Mar 08, 2025 18:07:50.468 [22985129851704] INFO - [Req#1e1c] AutoUpdate: no updates available
Mar 08, 2025 18:17:30.844 [22985364708152] WARN - JobManager: Could not find job for handle 13621
Mar 08, 2025 18:17:58.027 [22985038515000] WARN - [Req#2b67] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.029 [22985136245560] WARN - [Req#2b6b] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.029 [22985121590072] WARN - [Req#2b6d] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.030 [22985036405560] WARN - [Req#2b6a] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.046 [22985347181368] WARN - [Req#2b69] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.047 [22985129851704] WARN - [Req#2b6c] Missing X-Plex-Container-Size header. This will fail with status code 400 in the future.
Mar 08, 2025 18:17:58.077 [22985036405560] WARN - [Req#2b6a] SLOW QUERY: It took 240.000000 ms to retrieve 39 items.
Mar 08, 2025 18:17:58.115 [22985347181368] WARN - [Req#2b69] SLOW QUERY: It took 320.000000 ms to retrieve 19 items.
Mar 08, 2025 18:22:50.389 [22985136245560] INFO - [Req#31b8] AutoUpdate: no updates available

Well I’m back, issues persist even after changing the network config to a different IP to get rid of that secondary interface…

New logs attached now - live TV recording of “Forensic Factor” stopped at 13:54 - I can see the file in the .grab folder continuing to grow in size but the length remains at 13:54 no matter what.
The show is still airing live and I can try to watch from the beginning of the recording and it works, but if I go past 13:54 it will say Playback Error “This live TV session has ended”

I’ve also been able to get it to say
“An error occurred trying to play this item.
Error code: s3014 (Media)” when trying to play it starting at the live moment.

I CAN tune and watch it on HDHomeRun app so the tuner itself is working and signal is good.

Only relevant errors I’m seeing during trying to do the playback are

Full logs uploaded too though because I am at a total loss. any help is greatly appreciated!
Plex Media Server Logs_2025-03-09_09-31-57.zip (2.2 MB)