Scheduled recording didn't

Server Version#: 1.14.1.5488
Player Version#: 1.14.1.5488

A new series of ‘FBI’ episodes (Season 1, Ep 11) began last night and was scheduled to record, but today the Recodings calendar view shows nothing (no error reported there), and the TV Shows view only shows my previous Season 1 recordings. So it somehow got skipped.

Below is a snippet from the log showing lines listing the episode (apparently I had the debug log enabled; sorry)… it shows that the schedule was changed to delete the episode for some reason. This allows me to narrow the timeframe when the error happened, and so I’m attaching a complete extract of the log, but only lines logged between 14:43pm and 17:25pm (the error had to have been made during this time). – hmmn… how to attach a file here?

FWIW… It seems to me the online EPG was changed during this time frame, and the Refreshing Guide Data activity (incremental refresh for lineup) removed the scheduled show as it was not found in the EPG data it received?

Any help would be appreciated, Thanks
Tim

[tim1@pearl ~]$ cat /mnt/work/video/Plex_Media_Server.1.log | grep "FBI - E11 - Identity Crisis"
Jan 08, 2019 13:25:43.656 [0x7f13517ff700] DEBUG - DVR:Subscription: No match in the library for 'FBI - E11 - Identity Crisis', grabbing.
Jan 08, 2019 13:25:43.679 [0x7f1372fff700] DEBUG -  DVR:NewSchedule: Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:43.679 [0x7f1372fff700] DEBUG -  DVR:NewSchedule:    Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:43.680 [0x7f1372fff700] DEBUG -  DVR:NewSchedule: device 1 tuner 0 airing 0 between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:43.680 [0x7f1372fff700] DEBUG - DVR:Grabber: Scheduling 'FBI - E11 - Identity Crisis' for timed grab at 2019-01-08 19:57:00 (in 23477 seconds)
Jan 08, 2019 13:25:48.617 [0x7f134ffff700] DEBUG - DVR:Subscription: No match in the library for 'FBI - E11 - Identity Crisis', grabbing.
Jan 08, 2019 13:25:48.683 [0x7f13727fe700] DEBUG -  DVR:NewSchedule: Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:48.683 [0x7f13727fe700] DEBUG -  DVR:NewSchedule:    Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:48.683 [0x7f13727fe700] DEBUG -  DVR:NewSchedule: device 1 tuner 0 airing 0 between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 13:25:48.683 [0x7f13727fe700] DEBUG - DVR:Grabber: Scheduling 'FBI - E11 - Identity Crisis' for timed grab at 2019-01-08 19:57:00 (in 23472 seconds)
Jan 08, 2019 14:42:44.198 [0x7f13677ff700] DEBUG -  DVR:NewSchedule: Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:42:44.198 [0x7f13677ff700] DEBUG -  DVR:NewSchedule:    Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:42:44.198 [0x7f13677ff700] DEBUG -  DVR:NewSchedule: device 1 tuner 0 airing 0 between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:42:44.199 [0x7f13677ff700] DEBUG - DVR:Grabber: Scheduling 'FBI - E11 - Identity Crisis' for timed grab at 2019-01-08 19:57:00 (in 18856 seconds)
Jan 08, 2019 14:43:42.895 [0x7f1361fff700] DEBUG -  DVR:NewSchedule: Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.895 [0x7f1361fff700] DEBUG -  DVR:NewSchedule:    Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.895 [0x7f1361fff700] DEBUG -  DVR:NewSchedule: device 1 tuner 0 airing 0 between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.895 [0x7f1361fff700] DEBUG - DVR:Grabber: Scheduling 'FBI - E11 - Identity Crisis' for timed grab at 2019-01-08 19:57:00 (in 18798 seconds)
Jan 08, 2019 14:43:42.907 [0x7f13553ff700] DEBUG -  DVR:NewSchedule: Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.907 [0x7f13553ff700] DEBUG -  DVR:NewSchedule:    Between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.907 [0x7f13553ff700] DEBUG -  DVR:NewSchedule: device 1 tuner 0 airing 0 between 2019-01-08 19:57:00 and 2019-01-08 21:03:00 on channel 42.1: 'FBI - E11 - Identity Crisis'
Jan 08, 2019 14:43:42.907 [0x7f13553ff700] DEBUG - DVR:Grabber: Scheduling 'FBI - E11 - Identity Crisis' for timed grab at 2019-01-08 19:57:00 (in 18798 seconds)
Jan 08, 2019 17:25:43.654 [0x7f1364ffe700] DEBUG - DVR:Grabber: Cancelling operation for 'FBI - E11 - Identity Crisis' on channel 42.1 with status cancelled.
[tim1@pearl ~]$

When I saw your post I went to check my servers to see if the shows recorded and they did not, found the same cancel messages in my logs. Did a quick web search since the Presidents address and the Democrats response were on last night and found several links discussing the cancellations including this link:

1 Like

Oh yeah, I didn’t think of that – in fact I tried to forget ;-/

That hopefully explains it, Thanks!
Tim

1 Like

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.