Records Interruptet / Cancelling stream after 6s read timeout

Channels DVR Server Troubleshooting
#1

I often have interrupt recordings. About 40% are faulty.
I operate Channels DVR in a Docker and as a TV receiver I have Hdhomerun HDHR5-4DC.
Channel DVR version is: 2020.12.02.1531

The HDHOMR logfile shows:
20201207-17: 01: 04 Tuner: tuner0 http stream ended (remote closed)
and on channels
2020/12/07 18: 00: 57.468674 [TNR] Canceling stream 14200436/0 ch21 after 6s read timeout

Who has interrupted now. HDHomerun writes remtoe cleosed. That would be called Channels canceled for 6 seconds.
There are always 6 seconds interruption if the recording was interrupted.

HDHOMERUN LOG

20201206-21:47:16 Tuner: tuner3 lockkey forced release by 192.168.1.85
20201206-22:01:04 Tuner: tuner3 http stream ended (remote closed)
20201206-22:35:00 Tuner: tuner0 http stream ended (remote closed)
20201207-10:31:07 Tuner: tuner3 tuning 38 3sat HD (a8qam256-6900:714MHz-2391)
20201207-10:31:07 Tuner: tuner3 streaming http to 192.168.1.85:55207
20201207-10:31:07 Tuner: tuner3 lockkey forced release by 192.168.1.85
20201207-10:31:35 Tuner: tuner3 http stream ended (remote closed)
20201207-10:31:35 Tuner: tuner3 tuning 1 SRF 1 HD (a8qam256-6900:522MHz-2021)
20201207-10:31:35 Tuner: tuner3 streaming http to 192.168.1.85:55209
20201207-10:31:35 Tuner: tuner3 lockkey forced release by 192.168.1.85
20201207-10:32:42 Tuner: tuner3 http stream ended (remote closed)

20201207-16:55:00 Tuner: tuner0 tuning 21 Das Erste HD (a8qam256-6900:714MHz-2211)
20201207-16:55:00 Tuner: tuner0 streaming http to 192.168.1.90:36838
20201207-17:01:04 Tuner: tuner0 http stream ended (remote closed)
20201207-17:01:05 Tuner: tuner0 tuning 21 Das Erste HD (a8qam256-6900:714MHz-2211)
20201207-17:01:05 Tuner: tuner0 streaming http to 192.168.1.90:38986

20201207-17:19:00 Tuner: tuner1 tuning 23 ORF 1 HD (a8qam256-6900:522MHz-2221)
20201207-17:19:00 Tuner: tuner1 streaming http to 192.168.1.90:45360
20201207-18:07:00 Tuner: tuner1 http stream ended (remote closed)

20201207-19:00:00 Tuner: tuner0 http stream ended (remote closed)
20201207-19:04:00 Tuner: tuner0 tuning 1 SRF 1 HD (a8qam256-6900:522MHz-2021)
20201207-19:04:00 Tuner: tuner0 streaming http to 192.168.1.90:53892
20201207-20:10:00 Tuner: tuner0 http stream ended (remote closed)
20201207-21:40:00 Tuner: tuner0 tuning 56 ServusTV HD (a8qam256-6900:714MHz-2341)
20201207-21:40:00 Tuner: tuner0 streaming http to 192.168.1.90:49816
20201207-23:00:01 Tuner: tuner0 http stream ended (remote closed)

=====================================================================
CHANNELS DVR LOG

2020/12/07 00:33:19.384831 [IDX] Pruned 0 expired groups from CHE-1000429-DEFAULT in 1.467934ms.
2020/12/07 00:33:19.506260 [IDX] Pruned 5287 expired airings from CHE-1000429-DEFAULT in 118.873636ms.
2020/12/07 00:33:19.524103 [DVR] Rule 'Wer weiß denn sowas?' (4) found 1 new airings
2020/12/07 00:33:19.539902 [DVR] queued recording job for SH022087220000-1608656400 @ Tue Dec 22 5:55:00PM (1608656100-4)
2020/12/07 00:33:19.835700 [DVR] Waiting 17h21m40.164304743s until next job 1607360100-4 Wer weiß denn sowas?

2020/12/07 09:50:14.271141 [SYS] Shutting down...
2020/12/07 09:50:14.279978 [SYS] Bonjour service stopped.
2020/12/07 09:50:14.290784 [DVR] Recording engine stopped.
2020/12/07 09:50:15.290925 [SYS] Goodbye.
2020/12/07 09:50:41.992422 [SYS] Starting Channels DVR v2020.12.02.1531 (linux-x86_64 pid:1) in /channels-dvr/data
2020/12/07 09:50:42.027123 [SYS] Started HTTP Server
2020/12/07 09:50:42.941555 [HDR] Found 1 devices
2020/12/07 09:50:44.907432 [DVR] Recording engine started in /shares/DVR
2020/12/07 09:50:44.907714 [SYS] Bonjour service running for dvr-e905fdc1fd78.local. [172.18.0.10]
2020/12/07 09:50:44.924056 [DVR] Waiting 8h4m15.075952141s until next job 1607360100-4 Wer weiß denn sowas?
2020/12/07 09:50:46.212448 [SYS] Created database snapshot: backup-20201207.095046
2020/12/07 09:50:46.341441 [SYS] Removing old backup backup-20201112.062224
2020/12/07 09:50:50.930448 [NAT] Failed to discover upnp routers
2020/12/07 09:50:50.930471 [NAT] Failed to discover router using natpmp and upnp.
2020/12/07 09:50:55.013538 [IDX] Pruned 2051 expired airings from CHE-1000429-DEFAULT in 73.8466ms.

2020/12/07 17:55:00.005524 [DVR] Starting job 1607360100-4 Wer weiß denn sowas? on ch=[21]
2020/12/07 17:55:00.008620 [DVR] Waiting 23m59.991386752s until next job 1607361540-13 Q1 Ein Hinweis ist falsch
2020/12/07 17:55:00.120349 [TNR] Opened connection to 14200436/0 for ch21 Das Erste HD
2020/12/07 17:55:00.337721 [DVR] Recording for job 1607360100-4 from 14200436 ch21 into "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg" for 59m59.990952297s
2020/12/07 17:55:00.378485 [IDX] Generating video index for job 1607360100-4
2020/12/07 18:00:57.468674 [TNR] Cancelling stream 14200436/0 ch21 after 6s read timeout
2020/12/07 18:00:57.468860 [TNR] Closed connection to 14200436/0 for ch21 Das Erste HD
2020/12/07 18:00:57.476934 [SNR] Statistics for "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg": ss=100% snq=100% seq=99%,0%-100% bps=8537551,0-14667008 pps=810,0-1393
2020/12/07 18:01:05.051607 [DVR] Job 1607360100-4 Wer weiß denn sowas? ended prematurely: 53m54.948406273s
2020/12/07 18:01:05.064515 [DVR] Starting job 1607360100-4 Wer weiß denn sowas? on ch=[21]
2020/12/07 18:01:05.064571 [DVR] Waiting 17m54.935434428s until next job 1607361540-13 Q1 Ein Hinweis ist falsch
2020/12/07 18:01:05.218665 [TNR] Opened connection to 14200436/0 for ch21 Das Erste HD
2020/12/07 18:01:05.248936 [DVR] Recording for job 1607360100-4 from 14200436 ch21 into "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg" for 53m54.93540043s
2020/12/07 18:19:00.002462 [DVR] Starting job 1607361540-13 Q1 Ein Hinweis ist falsch on ch=[23]
2020/12/07 18:19:00.004062 [DVR] Waiting 27m59.995944818s until next job 1607363220-34 Morden im Norden
2020/12/07 18:19:00.195704 [TNR] Opened connection to 14200436/1 for ch23 ORF 1 HD
2020/12/07 18:19:00.355349 [DVR] Recording for job 1607361540-13 from 14200436 ch23 into "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-07 2020-12-07-1819.mpg" for 47m59.995909661s
2020/12/07 18:19:00.391800 [IDX] Generating video index for job 1607361540-13
2020/12/07 18:47:00.001877 [DVR] Starting job 1607363220-34 Morden im Norden on ch=[21]
2020/12/07 18:47:00.002476 [DVR] Waiting 1h16m59.997532557s until next job 1607367840-25 1 gegen 100
2020/12/07 18:47:00.002567 [TNR] Sharing existing connection to 14200436/0 for ch21 Das Erste HD (clients=2, len=0)
2020/12/07 18:47:00.070844 [DVR] Recording for job 1607363220-34 from 14200436 ch21 into "TV/Morden im Norden/Morden im Norden S06E19 2020-12-07 Aus gutem Hause 2020-12-07-1847.mpg" for 1h12m59.997495666s
2020/12/07 18:47:00.110390 [IDX] Generating video index for job 1607363220-34
2020/12/07 18:55:00.160784 [SNR] Statistics for "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg": ss=100% snq=100% seq=99%,0%-100% bps=8934936,0-16816224 pps=848,0-1598
2020/12/07 18:55:00.173848 [DVR] Finished job 1607360100-4 Wer weiß denn sowas?
2020/12/07 18:55:00.194942 [DVR] Waiting 1h8m59.805063632s until next job 1607367840-25 1 gegen 100
2020/12/07 18:55:00.238354 [DVR] Processing file-723: TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg
2020/12/07 18:55:00.911749 [DVR] Running commercial detection on file 723 (TV/Wer weiß denn sowas/Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg)
2020/12/07 19:05:15.094260 [DVR] Commercial detection for Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg finished with 6 markers.
2020/12/07 19:05:15.890995 [IDX] Generating video index for file-723: Wer weiß denn sowas S06E29 2020-12-07 Gste Alexander Kumptner Frank Rosin 2020-12-07-1755.mpg
2020/12/07 19:06:00.012335 [IDX] Finished video index generation for file-723 in 44s
2020/12/07 19:07:00.191768 [TNR] Closed connection to 14200436/1 for ch23 ORF 1 HD
2020/12/07 19:07:00.204721 [SNR] Statistics for "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-07 2020-12-07-1819.mpg": ss=100% snq=100% seq=99%,0%-100% bps=9321407,0-17244864 pps=885,0-1638
2020/12/07 19:07:00.405722 [DVR] Finished job 1607361540-13 Q1 Ein Hinweis ist falsch
2020/12/07 19:07:00.430582 [DVR] Waiting 56m59.56942291s until next job 1607367840-25 1 gegen 100
2020/12/07 19:07:00.456103 [DVR] Processing file-724: TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-07 2020-12-07-1819.mpg
2020/12/07 19:07:01.811922 [DVR] Running commercial detection on file 724 (TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-07 2020-12-07-1819.mpg)
2020/12/07 19:17:26.533802 [DVR] Commercial detection for Q1 Ein Hinweis ist falsch 2020-12-07 2020-12-07-1819.mpg finished with 4 markers.
2020/12/07 20:00:00.000532 [TNR] Closed connection to 14200436/0 for ch21 Das Erste HD
2020/12/07 20:00:00.010376 [SNR] Statistics for "TV/Morden im Norden/Morden im Norden S06E19 2020-12-07 Aus gutem Hause 2020-12-07-1847.mpg": ss=100% snq=100% seq=99%,0%-100% bps=8499047,0-16816224 pps=807,0-1598
2020/12/07 20:00:00.274595 [DVR] Finished job 1607363220-34 Morden im Norden

Can someone give me a tip

#2

First guess is that you are having networking problems. How are the machine running docker and the HDHR connected to the network?

#3

I see your signal strength as 100%. Is it possible that the tuner is having issues by an over-powered signal? Is the problem only on channel 21? Also, the seq totals in the SNR stats line for the stream show that there were errors.

I see that channel 56 is also at 714MHz ... it looks like it shares a mux with 21. Does 56 have any issues? Also, around 700MHz seems to sometimes have issues with LTE/cell signals; have you tried putting an LTE filter on your line?

#4

I have an i7 computer with 64GB Ram. I installed Proxmox on it. In the proxmox environment I set up a Windows 10 installation and an Ubuntu server 18.04.
I installed various Dockers on the Ubuntu server.
Plex, Treafik, Home Assistant and channelds-dvr.

I've been using Channels-dvr and HDHomrrun for several years. I have only interrupted the recording for about half a year.

Last year I had a service man from the cable TV provider in my apartment for measurements. He has confirmed that a nearby cell phone antenna has strong signals. He sells me well shielded cables. With the new cables, I was able to receive TV channels that were previously very badly disturbed.
No, I haven't tried an LTE filter yet.

Until April I had installed Ubuntu directly on my computer with the various Docker images. In April I set up the computer again and used OS Proxmox as a basic.
Can that lead to problems for Channels-dvr?

#5

The easiest thing to try is the filter. Another option that works for some is to use an attenuator or splitter to reduce the strength of the signal. (As I previously mentioned, overpowered signals are common issues with SiliconDust tuners.)

As far as the Proxmox: personally I've never used it, so I can't really say. However, there was another user on the forum who had a similar situation as you I believe, and was using Proxmox. You may want to search the forum for the thread and reach out to him. I don't recall the details, but it's worth investigating.

Sorry I can't be of more help. Good luck.

#6

Thank you racameron.
The way I understand you, you assume that the HDHomerun generates the interruptions.
When I look at the HDHomerun Logfiel it says "http stream ended (remote closed)".
I interpret the Channels-DVR interrupted the stream.

The current Channels-DVR is larger than 173,000 lines and it contains 58 lines with "Canceling stream" and all lines have a 6sec read timeout. For me it's strange that an EMC problem always 6 seconds. lasts.
Can't the interruption be on the channel DVR side?

I have stored the complete HdHomerun and Channels DVR log file on my Goolgedrive.
https://drive.google.com/file/d/1wg-My0z5BVzBZsdWmit-ko4ICF1-Qlpf/view?usp=sharing

#7

I'm shooting in the dark, because there is such limited information given. You claim these issues started when two things changed (unless I misunderstood):

  1. New wiring
  2. The move from bare metal to Proxmox

In relation to the first, I suggested the culprit could be either an overly strong signal, or interference. An attenuator or splitter would aid with the former, and a filter for the latter. But beyond your initial concrete example, you haven't shared which exact channels this is happening with to see if there's a pattern. (Yes, you've linked to your logs, but I don't really want to scan through thousands of lines looking for the relevant information.)

In connection to the second, I've shared there was a previous user with a similar setup and issues. That user may have more information and be able to better aid you, as there are too many layers to easily narrow your problem down. (You've got your hypervisor, the virtual machine, and the container; each level adds new points of failure.)

In any situation, trying the initial easy fixes seems like a good first step. After that, reducing the situation to the bare minimum and slowly scaling back up to isolate the issue would be my plan of attack.

Also, have you tried testing the channel outside of Channels? Using VLC or similar? Also, is your firmware up-to-date? Your mention of cable and channels makes me think you're using an Expand (Gen3 DVB-C tuner)? If so, that is pretty similar hardware-wise to the Prime, which has had numerous firmware issues over the years.

(Edit: I mixed up the model name of the Expand with the Extend. I did mean Expand, which is their DVB-C model. Although, I guess that's no longer the case as all DVB tuners can now tune DVB-C after a recent firmware update.)

#8

6s is a timeout inside our dvr. If no video or audio is received in 6s, the connection is closed. This could happen due to antenna signal or network transmission issues.

#9

Thanks for the support.
That helped me a lot.

I have the HDHomeRun EXPAND (HDHR5-4DC) for Switzerland.
Is the current firmware 20200907 on it.

In principle, it works really well until about 40% of the recordings are interrupted.
When watching live, I've never had a problem.
As a client I use Sony Android Tv or VLC on the Mac on Apple TV.

I interrupted recordings at the following stations:
Servus TV (714000 kHz)
ORF 1 (522000 kHz)
ARD (714000 kHz)
Sat 1 (53000 kHz)
BR (802000 kHz)

I still found a couple of TV splitters. I'll switch them in between tomorrow.

#10

On my.hdhomerun.com under Tuner Status check what the signal strength and quality are shown as while watching or recording.

If you watch live, does it also cut out? Or only recordings are affected?

#11

While watching it live, it hasn’t never been noticed until now.
I watch live TV, but not much.

These are the print screens of the current recordings
HDHomeRun Tuner Status 2020-12-09 19-21-57

HDHomeRun Tuner Status 2020-12-09 19-30-28

2020/12/09 13:25:45.701111 [DVR] Deleting /shares/DVR/TV/ZDF-History/ZDF-History 2018-06-03 Mallorca Eine deutsche Liebe 2020-11-29-0909.mpg
2020/12/09 13:25:45.908115 [DVR] Deleting /shares/DVR/TV/Quizduell - Olymp/Quizduell - Olymp S05E09 2019-03-08 Gste Ludwig Trepte und Florian Bartholomi 2020-11-20-1847.mpg
2020/12/09 17:55:00.001753 [DVR] Starting job 1607532900-4 Wer weiß denn sowas? on ch=[21]
2020/12/09 17:55:00.001810 [DVR] Waiting 23m59.998194556s until next job 1607534340-13 Q1 Ein Hinweis ist falsch
2020/12/09 17:55:00.225350 [TNR] Opened connection to 14200436/0 for ch21 Das Erste HD
2020/12/09 17:55:00.260241 [DVR] Recording for job 1607532900-4 from 14200436 ch21 into "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg" for 59m59.998150737s
2020/12/09 17:55:00.299316 [IDX] Generating video index for job 1607532900-4
2020/12/09 18:19:00.002649 [DVR] Starting job 1607534340-13 Q1 Ein Hinweis ist falsch on ch=[23]
2020/12/09 18:19:00.004471 [DVR] Waiting 29m59.99553898s until next job 1607536140-9 Hubert ohne Staller
2020/12/09 18:19:00.102775 [TNR] Opened connection to 14200436/1 for ch23 ORF 1 HD
2020/12/09 18:19:00.154595 [DVR] Recording for job 1607534340-13 from 14200436 ch23 into "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg" for 47m59.995497086s
2020/12/09 18:19:00.191770 [IDX] Generating video index for job 1607534340-13
2020/12/09 18:49:00.003372 [DVR] Starting job 1607536140-9 Hubert ohne Staller on ch=[21]
2020/12/09 18:49:00.005499 [DVR] Waiting 32m59.994509362s until next job 1607538120-31 Heldt
2020/12/09 18:49:00.005594 [TNR] Sharing existing connection to 14200436/0 for ch21 Das Erste HD (clients=2, len=0)
2020/12/09 18:49:00.017239 [DVR] Recording for job 1607536140-9 from 14200436 ch21 into "TV/Hubert ohne Staller/Hubert ohne Staller S09E09 2020-12-09 Zu spte Einsicht 2020-12-09-1849.mpg" for 1h0m59.994458621s
2020/12/09 18:49:00.059764 [IDX] Generating video index for job 1607536140-9
2020/12/09 18:55:00.232601 [SNR] Statistics for "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg": ss=100% snq=100% seq=100% bps=8922440,1067840-16495872 pps=847,102-1566
2020/12/09 18:55:00.502540 [DVR] Finished job 1607532900-4 Wer weiß denn sowas?
2020/12/09 18:55:00.528664 [DVR] Waiting 26m59.471350199s until next job 1607538120-31 Heldt
2020/12/09 18:55:00.552940 [DVR] Processing file-729: TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg
2020/12/09 18:55:01.532783 [DVR] Running commercial detection on file 729 (TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg)
2020/12/09 19:07:00.098663 [TNR] Closed connection to 14200436/1 for ch23 ORF 1 HD
2020/12/09 19:07:00.109411 [SNR] Statistics for "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg": ss=100% snq=100% seq=100% bps=9254901,2773376-17249376 pps=879,264-1638
2020/12/09 19:07:00.669245 [DVR] Finished job 1607534340-13 Q1 Ein Hinweis ist falsch
2020/12/09 19:07:00.693638 [DVR] Waiting 14m59.306369762s until next job 1607538120-31 Heldt
2020/12/09 19:08:11.393441 [DVR] Commercial detection for Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg finished with 4 markers.
2020/12/09 19:08:12.059448 [DVR] Processing file-730: TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg
2020/12/09 19:08:12.914799 [DVR] Running commercial detection on file 730 (TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg)
2020/12/09 19:18:42.402186 [DVR] Commercial detection for Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg finished with 4 markers.
2020/12/09 19:22:00.001549 [DVR] Starting job 1607538120-31 Heldt on ch=[22]
2020/12/09 19:22:00.001606 [DVR] Waiting 22h32m59.998398968s until next job 1607619300-4 Wer weiß denn sowas?
2020/12/09 19:22:00.140608 [TNR] Opened connection to 14200436/1 for ch22 ZDF HD
2020/12/09 19:22:00.225574 [DVR] Recording for job 1607538120-31 from 14200436 ch22 into "TV/Heldt/Heldt S08E06 2020-10-14 Die Trume der Anderen 2020-12-09-1922.mpg" for 1h7m59.998375093s
2020/12/09 19:22:00.263725 [IDX] Generating video index for job 1607538120-31

=== HDHOME RUN
2020/12/09 13:25:45.908115 [DVR] Deleting /shares/DVR/TV/Quizduell - Olymp/Quizduell - Olymp S05E09 2019-03-08 Gste Ludwig Trepte und Florian Bartholomi 2020-11-20-1847.mpg
2020/12/09 17:55:00.001753 [DVR] Starting job 1607532900-4 Wer weiß denn sowas? on ch=[21]
2020/12/09 17:55:00.001810 [DVR] Waiting 23m59.998194556s until next job 1607534340-13 Q1 Ein Hinweis ist falsch
2020/12/09 17:55:00.225350 [TNR] Opened connection to 14200436/0 for ch21 Das Erste HD
2020/12/09 17:55:00.260241 [DVR] Recording for job 1607532900-4 from 14200436 ch21 into "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg" for 59m59.998150737s
2020/12/09 17:55:00.299316 [IDX] Generating video index for job 1607532900-4
2020/12/09 18:19:00.002649 [DVR] Starting job 1607534340-13 Q1 Ein Hinweis ist falsch on ch=[23]
2020/12/09 18:19:00.004471 [DVR] Waiting 29m59.99553898s until next job 1607536140-9 Hubert ohne Staller
2020/12/09 18:19:00.102775 [TNR] Opened connection to 14200436/1 for ch23 ORF 1 HD
2020/12/09 18:19:00.154595 [DVR] Recording for job 1607534340-13 from 14200436 ch23 into "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg" for 47m59.995497086s
2020/12/09 18:19:00.191770 [IDX] Generating video index for job 1607534340-13
2020/12/09 18:49:00.003372 [DVR] Starting job 1607536140-9 Hubert ohne Staller on ch=[21]
2020/12/09 18:49:00.005499 [DVR] Waiting 32m59.994509362s until next job 1607538120-31 Heldt
2020/12/09 18:49:00.005594 [TNR] Sharing existing connection to 14200436/0 for ch21 Das Erste HD (clients=2, len=0)
2020/12/09 18:49:00.017239 [DVR] Recording for job 1607536140-9 from 14200436 ch21 into "TV/Hubert ohne Staller/Hubert ohne Staller S09E09 2020-12-09 Zu spte Einsicht 2020-12-09-1849.mpg" for 1h0m59.994458621s
2020/12/09 18:49:00.059764 [IDX] Generating video index for job 1607536140-9
2020/12/09 18:55:00.232601 [SNR] Statistics for "TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg": ss=100% snq=100% seq=100% bps=8922440,1067840-16495872 pps=847,102-1566
2020/12/09 18:55:00.502540 [DVR] Finished job 1607532900-4 Wer weiß denn sowas?
2020/12/09 18:55:00.528664 [DVR] Waiting 26m59.471350199s until next job 1607538120-31 Heldt
2020/12/09 18:55:00.552940 [DVR] Processing file-729: TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg
2020/12/09 18:55:01.532783 [DVR] Running commercial detection on file 729 (TV/Wer weiß denn sowas/Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg)
2020/12/09 19:07:00.098663 [TNR] Closed connection to 14200436/1 for ch23 ORF 1 HD
2020/12/09 19:07:00.109411 [SNR] Statistics for "TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg": ss=100% snq=100% seq=100% bps=9254901,2773376-17249376 pps=879,264-1638
2020/12/09 19:07:00.669245 [DVR] Finished job 1607534340-13 Q1 Ein Hinweis ist falsch
2020/12/09 19:07:00.693638 [DVR] Waiting 14m59.306369762s until next job 1607538120-31 Heldt
2020/12/09 19:08:11.393441 [DVR] Commercial detection for Wer weiß denn sowas S06E35 2020-12-09 Gste Eva Padberg Kim Riekenberg 2020-12-09-1755.mpg finished with 4 markers.
2020/12/09 19:08:12.059448 [DVR] Processing file-730: TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg
2020/12/09 19:08:12.914799 [DVR] Running commercial detection on file 730 (TV/Q1 Ein Hinweis ist falsch/Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg)
2020/12/09 19:18:42.402186 [DVR] Commercial detection for Q1 Ein Hinweis ist falsch 2020-12-09 2020-12-09-1819.mpg finished with 4 markers.
2020/12/09 19:22:00.001549 [DVR] Starting job 1607538120-31 Heldt on ch=[22]
2020/12/09 19:22:00.001606 [DVR] Waiting 22h32m59.998398968s until next job 1607619300-4 Wer weiß denn sowas?
2020/12/09 19:22:00.140608 [TNR] Opened connection to 14200436/1 for ch22 ZDF HD
2020/12/09 19:22:00.225574 [DVR] Recording for job 1607538120-31 from 14200436 ch22 into "TV/Heldt/Heldt S08E06 2020-10-14 Die Trume der Anderen 2020-12-09-1922.mpg" for 1h7m59.998375093s
2020/12/09 19:22:00.263725 [IDX] Generating video index for job 1607538120-31

#12

This looks good. Signal is 100% (is it amplified?), and pps/bps never hit zero:

If you look at the same lines from your earlier log, the situation is not as good. The pps/bps is dropping to 0, and must be at 0 for 6 seconds before the timeout error would happen.

#13

The HDHomeRun receiver is connected directly to the wall socket with a cable, so no amplifiers are connected.
I have now switched 2 TV splitters in series in between to weaken the signal. Just like racameron recommended it.
The signal strength is now 80%. I will now watch it all.
Thank you

HDHomeRun Tuner Status 2020-12-10 10-55-11

#14

Today I took 5 sample recordings, some of them were even at the same time.
At 3:51 pm there was the interruption again and thus the last 2 recordings were interrupted.
Unfortunately, I don't have the knowledge to interpret the signal strengths in the log file,
In the logfile I have colored the two programs with different colors so that it is easier to read.
Can each read something out there?

Channels DVR 2020-12-10 17-30-24
Channels DVR 2020-12-10 17-30-241260×1162 271 KB

Multimedia 2020-12-10 17-31-46
Multimedia 2020-12-10 17-31-463298×2310 1.55 MB

#15

What is the network path between the HDHR and the DVR?

#16

2 switches. The switch from the Netgear Orbi and a simple GS Netgear switch.

#17

It is preferred that the dvr and the HDHR be plugged into the same physical switch

#18

Since both tuner 0 and 2 timed out at the same time 2020/12/10 15:51:13 it does appear to be a network or HDHR issue. Or, both of those channels (56 and 70) are on the same frequency.

1 Like
#19

It's worth emailing [email protected] with your HDHR device ID to see if they can tell anything more from the HDHR diagnostics

You will need to enable the checkbox on my.hdhomerun.com to send them extra diagnostics

#20

I wrote the support from Silicondust. I'm curious if they can help me.