Server Version#: 1.20.2.3370
Player Version#: Web 4.43.1
Tuner Make/Model: Hauppauge WinTV quadHD USB
Guide/Lineup name: Broadcast TV Omaha OTA Broadcast
Using XMLTV?: no
Channel number/Name: multiple (in this case 6.3, 7.2, 32.1)
I have “a lot” (?) of recordings scheduled. It’s not uncommon to have 2 concurrent, and a few times a day 3 concurrent. 4 is rare, but happens.
Sometimes one of the recordings fails and reports ‘airing was in progress’. One particular case is when 3 shows are ending at the same time and 2 are starting immediately after. I’m sure there is some amount of delay between ending a show, releasing the tuner, and starting the next. However, I purchased a 4 tuner device so I could do this many recordings. What is the allowed time for releasing the tuner and allocating to the next?
I have the partial recordings turned off because I was deleting several a week that were half of the show. It was due to signal quality, I’ve since adjusted my antenna. However, I don’t want to turn partial recordings back and then need to check every show.
I’ve also written a script to adjust CPU and IO priorities for the tuner service and transcoders for livetv/dvr so other normal processes don’t delay them.
You may still be having some signal quality issues. The logging shows that the recording actually starts and runs for ~25 seconds. The transcoder then fails, presumably because it is starved for data from the tuner and can’t start its transcoding session:
Oct 05, 2020 08:00:25.903 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] TranscodeSession: timed out waiting to find duration for live session
Oct 05, 2020 08:00:25.903 [0x7fe373fff700] ERROR - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Failed to start session.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Streaming Resource: Terminated session 0x7fe3844ed970:5c9c1ad7-6a93-41fa-bef5-985dd476e8f8 with reason Recording failed. Please check your tuner or antenna.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] ERROR - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Recorder: Unable to create transcode session or session failed to start.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Killing job.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Signalling job ID 2638572 with 9
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] ERROR - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Recorder: Error 16 (Recording failed. Please check your tuner or antenna.) starting the record, shutting things down.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] MediaRecorderVirtual: setting stop time to 2020-10-05 08:00:25
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Recorder: Asked to stop recording 'Rawhide - E18 - Deserters' Patrol' on channel 6.3.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Grabber: Freed a tuner on device://tv.plex.grabbers.tunerservice/dvb%23v4l%23%2fsys%2fdevices%2fpci0000%3a00%2f0000%3a00%3a14.0%2fusb2%2f2-3%2f2-3.1%2f2-3.1%3a1.0%3a0014128948 (now 1 available)
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] ERROR - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Recorder: Error 16 (Recording failed. Please check your tuner or antenna.) starting the record, shutting things down.
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] MediaRecorderVirtual: setting stop time to 2020-10-05 08:00:25
Oct 05, 2020 08:00:25.904 [0x7fe373fff700] DEBUG - [Grabber/c04c49b715132d78905c50a757432a4213e5122f] Grabber: Operation for 'Rawhide - E18 - Deserters' Patrol' on channel 6.3 completed with status error (Recording failed. Please check your tuner or antenna.)
The other error, failing to record because the airing was in progress, comes about five minutes later when it attempts to restart the recording:
Oct 05, 2020 08:05:41.434 [0x7fe34a7fc700] DEBUG - Grabber: Operation for 'Rawhide - E18 - Deserters' Patrol' on channel 6.3 completed with status error (The recording was not started because airing was in progress)
Oct 05, 2020 08:05:41.434 [0x7fe34a7fc700] WARN - DVR:NewSchedule: Couldn't schedule recording (error: The recording was not started because airing was in progress).
Makes sense now. I thought that if the recording couldn’t start because the tuner couldn’t get a signal, I’d get the first error about the tuner and it would remain on that error. I didn’t realize it would try again and then report the ‘airing in progress’.
I see some signal problems for that station on rabbitears.info. Not sure if the time zone is correct on the graph, but definitely something going on.
