Recordings not starting

[sward 28]

I've noticed that about 10% of my recordings never launch. In the latest example, the French Open was supposed to start recording at 5:00AM this morning, but didn't. I'm attaching the relevant logs. Strangely there's nothing in the logs regarding this recording, but when I came down at 6:00AM I could still see "2024 Roland-Garros Tennis" listed in the recording schedule for 5AM to 1PM.

embyserver.txt embyserver-63852641100.txt

[Luke 39420]

Hi, it appears to have started:

2024-05-30 05:54:36.249 Info MediaSourceManager: Live stream opened: {"Protocol":"Http","Id":"native_040446e6e30c7182e0e68a54ba77ab1e_f8f181232418314d1bc8239f1eabc416","Path":"http://127.0.0.1:8096/LiveTv/LiveStreamFiles/32ffc863002941c6b9badb3dda56fc38/stream.ts","Type":"Default","ProbePath":"","ProbeProtocol":"File","Container":"mpegts","IsRemote":false,"HasMixedProtocols":false,"ContainerStartTimeTicks":682455102890,"SupportsTranscoding":true,"WallClockStart":"2024-05-30T09:54:35.3672649Z","SupportsDirectStream":true,"SupportsDirectPlay":false,"IsInfiniteStream":true,"RequiresOpening":true,"RequiresClosing":true,"LiveStreamId":"06044cf0e6f93cdae5f285c9ecfaaeb4_01413a525b3a9622ce6fdf19f7dde354_native_040446e6e30c7182e0e68a54ba77ab1e_f8f181232418314d1bc8239f1eabc416","RequiresLooping":false,"SupportsProbing":false,"MediaStreams":[{"Codec":"mpeg2video","StreamStartTimeTicks":682455279780,"TimeBase":"1/90000","VideoRange":"SDR","DisplayTitle":"1080i MPEG2VIDEO","IsInterlaced":true,"BitRate":15000000,"BitDepth":8,"RefFrames":1,"IsDefault":false,"IsForced":false,"IsHearingImpaired":false,"Height":1080,"Width":1920,"AverageFrameRate":29.97003,"RealFrameRate":29.97003,"Profile":"Main","Type":"Video","AspectRatio":"16:9","Index":0,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"Protocol":"File","PixelFormat":"yuv420p","Level":4,"IsAnamorphic":false,"ExtendedVideoType":"None","ExtendedVideoSubType":"None","ExtendedVideoSubTypeDescription":"None"},{"Codec":"ac3","Language":"eng","StreamStartTimeTicks":682455102890,"TimeBase":"1/90000","DisplayTitle":"English AC3 stereo","DisplayLanguage":"English","IsInterlaced":false,"ChannelLayout":"stereo","BitRate":192000,"Channels":2,"SampleRate":48000,"IsDefault":false,"IsForced":false,"IsHearingImpaired":false,"Type":"Audio","Index":1,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"Protocol":"File","ExtendedVideoType":"None","ExtendedVideoSubType":"None","ExtendedVideoSubTypeDescription":"None"},{"Codec":"ac3","Language":"spa","StreamStartTimeTicks":682455116670,"TimeBase":"1/90000","DisplayTitle":"Spanish AC3 mono","DisplayLanguage":"Spanish","IsInterlaced":false,"ChannelLayout":"mono","BitRate":192000,"Channels":1,"SampleRate":48000,"IsDefault":false,"IsForced":false,"IsHearingImpaired":false,"Type":"Audio","Index":2,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"Protocol":"File","ExtendedVideoType":"None","ExtendedVideoSubType":"None","ExtendedVideoSubTypeDescription":"None"},{"Codec":"eia_608","StreamStartTimeTicks":682455279780,"TimeBase":"1/90000","Title":"Closed Captions 1","DisplayTitle":"(Default EIA_608)","IsInterlaced":false,"IsDefault":true,"IsForced":false,"IsHearingImpaired":false,"Type":"Subtitle","Index":100,"IsExternal":false,"IsTextSubtitleStream":true,"SupportsExternalStream":false,"Protocol":"File","ExtendedVideoType":"None","ExtendedVideoSubType":"None","ExtendedVideoSubTypeDescription":"None","SubtitleLocationType":"VideoSideData"}],"Formats":[],"Bitrate":15384000,"RequiredHttpHeaders":{},"AddApiKeyToDirectStreamUrl":false,"ReadAtNativeFramerate":false,"DefaultAudioStreamIndex":1}
2024-05-30 05:54:36.250 Info LiveTV: Recording ensure file unique input: D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round.ts
2024-05-30 05:54:36.251 Info LiveTV: Recording ensure file unique result: D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round.ts
2024-05-30 05:54:36.251 Info LiveTV: Will record to D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round.ts for 455.395814905 minutes.
2024-05-30 05:54:36.275 Info LiveTV: Saving recording image to D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round-thumb.jpg
2024-05-30 05:54:36.276 Info LiveTV: Triggering refresh on D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round.ts
2024-05-30 05:54:36.276 Info LiveTV: Refreshing recording parent D:\Recorded TV\Emby
2024-05-30 05:54:36.277 Info LiveTV: Copying recording stream to file D:\Recorded TV\Emby\2024 Roland-Garros Tennis\2024 Roland-Garros Tennis 2024_05_30_05_00_00 - Second Round.ts
2024-05-30 05:56:06.358 Info LibraryMonitor: 2024 Roland-Garros Tennis (D:\Recorded TV\Emby\2024 Roland-Garros Tennis) will be refreshed.

 

[sward 28]

Yes, that was me launching it manually when I came down around 6AM. Note it was supposed to launch at 5AM.

[sward 28]

So I have another example of a recording not starting, and a theory of what's happening. Per the attached log files, shortly after my computer wakes at 3:55AM we can see a correct recording timer for '2024 Roland-Garros Tennis' that's supposed to fire an hour later around 5AM:

2024-06-05 03:59:22.642 Info LiveTV: Creating recording timer for e4174aee419d9ccaa970ec33b9ebf24d, 2024 Roland-Garros Tennis. Timer will fire in 60.622619705 minutes

However, a few minutes later when Emby performs a scheduled guide refresh we can see that some of the Tennis Channel recordings cannot be retrieved:

2024-06-05 04:03:04.662 Info HttpClient: GET https://host4/v1.1/stations/60316/airings?lineupId=USA-MD67788-X&imageAspectTV=2x3&imageText=true&imageSize=Lg&startDateTime=2024-06-05T00:00Z&endDateTime=2024-06-20T00:00Z
2024-06-05 04:03:04.662 Error LiveTvManager: Error getting programs for channel Tennis Channel HD
    *** Error Report ***
    Version: 4.8.8.0
    Command line: C:\Emby-server\system\EmbyServer.dll -noautorunwebapp
    Operating system: Microsoft Windows 10.0.22631
    Framework: .NET 6.0.30
    OS/Process: x64/x64
    Runtime: C:/Emby-server/system/System.Private.CoreLib.dll
    Processor count: 24
    Data path: C:\Emby-server\programdata
    Application path: C:\Emby-server\system
    MediaBrowser.Model.Net.HttpException: MediaBrowser.Model.Net.HttpException: Cancelling connection to https://host4/v1.1/stations/60316/airings?lineupId=USA-MD67788-X&imageAspectTV=2x3&imageText=true&imageSize=Lg&startDateTime=2024-06-05T00:00Z&endDateTime=2024-06-20T00:00Z due to a previous timeout.
       at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod)
       at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod)
       at EmbyGuideData.Gracenote.GetProgramsAsync(ListingsProviderInfo info, String channelId, DateTimeOffset startDateUtc, DateTimeOffset endDateUtc, CancellationToken cancellationToken)
       at Emby.LiveTV.EmbyTV.GetProgramsAsync(ChannelInfo channel, List`1 listingsProviders, DateTimeOffset startDateUtc, DateTimeOffset endDateUtc, CancellationToken cancellationToken)
       at Emby.LiveTV.LiveTvManager.RefreshEmbyChannelsInternal(IProgress`1 progress, CancellationToken cancellationToken)
    Source: Emby.Server.Implementations
    TargetSite: Void MoveNext()
 

From this point on, the 5AM recording (e4174aee419d9ccaa970ec33b9ebf24d) is missing, and the next Roland Garros recording is now 626 minutes away instead of 60 minutes:

2024-06-05 04:03:19.928 Info HttpClient: GET https://api4.thetvdb.com/v4/search?type=series&q=2024 Roland-Garros Tennis
2024-06-05 04:03:20.000 Info HttpClient: GET https://api4.thetvdb.com/v4/search?type=series&q=2024 Roland Garros Tennis
2024-06-05 04:03:20.072 Info TheMovieDb: MovieDbProvider: Finding id for item: 2024 Roland-Garros Tennis
2024-06-05 04:03:20.072 Info HttpClient: GET https://api.themoviedb.org/3/search/tv?api_key=x_secret3_x&query=2024 Roland-Garros Tennis&language=en-US
2024-06-05 04:03:20.388 Info HttpClient: GET https://api.themoviedb.org/3/search/tv?api_key=x_secret3_x&query=2024 Roland Garros Tennis&language=en-US
2024-06-05 04:03:20.428 Info LiveTV: Creating recording timer for 832299e83b672a8f405ccd71a8847fa3, 2024 Roland-Garros Tennis. Timer will fire in 626.6595211516667 minutes
2024-06-05 04:03:20.465 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.481 Info LiveTV: Creating recording timer for d245603f136a3021802c7d6baf682abf, 2024 Roland-Garros Tennis. Timer will fire in 1736.65863526 minutes
2024-06-05 04:03:20.516 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.533 Info LiveTV: Creating recording timer for 99d4f6a0625df36fb6052c6127f9cd1a, 2024 Roland-Garros Tennis. Timer will fire in 2996.65777298 minutes
2024-06-05 04:03:20.533 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.550 Info LiveTV: Creating recording timer for ecd63082bf20600dc8d755669d484650, 2024 Roland-Garros Tennis. Timer will fire in 3146.65748803 minutes
2024-06-05 04:03:20.563 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.580 Info LiveTV: Creating recording timer for cbf396b8ea3fb9cb87b67c0f13128f0b, 2024 Roland-Garros Tennis. Timer will fire in 3596.6569956733333 minutes
2024-06-05 04:03:20.580 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.598 Info LiveTV: Creating recording timer for f680e1e27d3be84da13ce06bc9cf0e99, 2024 Roland-Garros Tennis. Timer will fire in 4076.656699986667 minutes
2024-06-05 04:03:20.598 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.616 Info LiveTV: Creating recording timer for c3e19143bf1f2d9d44782b1bc158d163, 2024 Roland-Garros Tennis. Timer will fire in 4616.656392621667 minutes
2024-06-05 04:03:20.665 Info LiveTV: Found existing series based on provider ids: 20344047
2024-06-05 04:03:20.682 Info LiveTV: Creating recording timer for 8ff4cf19c8ab42d91d46529a8bb70a21, 2024 Roland-Garros Tennis. Timer will fire in 6056.6552923066665 minutes
 

embyserver.txt embyserver-63853159500.txt

[Luke 39420]

I'm not sure that's it. Are you sure it showed in the schedule for the time that you were expecting?

[sward 28]

3 hours ago, Luke said:

I'm not sure that's it. Are you sure it showed in the schedule for the time that you were expecting?

Yes, of course, I provided you the log entry:

2024-06-05 03:59:22.642 Info LiveTV: Creating recording timer for e4174aee419d9ccaa970ec33b9ebf24d, 2024 Roland-Garros Tennis. Timer will fire in 60.622619705 minutes

I ended up having to manually launch this recording. Why does the above recording timer 'disappear'?

 

[Luke 39420]

Is this a one-off recording or part of a series recording?

[sward 28]

I was part of a series. I was recording all of the 2024 French Open / Roland Garros.

[Luke 39420]

On 6/10/2024 at 5:53 AM, sward said:

Yes, of course, I provided you the log entry:

2024-06-05 03:59:22.642 Info LiveTV: Creating recording timer for e4174aee419d9ccaa970ec33b9ebf24d, 2024 Roland-Garros Tennis. Timer will fire in 60.622619705 minutes

I ended up having to manually launch this recording. Why does the above recording timer 'disappear'?

 

Best guess is the guide data changed. The recording schedule will get updated to match the guide data when that happens. We'll have to add more logging to confirm this, but I think that is the most likely reason.

What you could do to help narrow this down is that if you see a recording disappear, go and check what the server has for the guide data in that timeslot.

[sward 28]

So the show was still in the EPG, which is how I was able to launch it manually. I just went into the EPG, located the show and launched it manually. In a previous instance it was still in my recording schedule, because these are ~5 hour recordings, but it just hadn't launched for some reason. I'm wondering if the identifier (in this case e4174aee419d9ccaa970ec33b9ebf24d) for the show changed after the update, which would presumably remove the recording timer. Next time I'll include the logs showing the manual launch, so we can compare identifiers.

[sa2000 323]

On 15/06/2024 at 11:50, sward said:

I'm wondering if the identifier (in this case e4174aee419d9ccaa970ec33b9ebf24d) for the show changed after the update, which would presumably remove the recording timer

Not sure how the id's area created. I presume you are referring to the timer id's. The episode ones I expect to be generated when a potential airing is seen in the guide. But the Series Timer ID is probably fixed. 

For next time, with the logs, could you also copy out these 2 files and zip them and attach

C:\Emby-server\programdata\data\livetv\seriestimers.json
C:\Emby-server\programdata\data\livetv\timers.json

And also what Luke suggested

Quote

 What you could do to help narrow this down is that if you see a recording disappear, go and check what the server has for the guide data in that timeslot.

Edit: emphasizing the "copy out these 2 files" rather than view or zip in-situ to avoid potentially causing conflicts with any emby-server update access to the files

Edit 2: including Luke's recommendation and removing reference to access issue for timers.json (which was for a different forum thread - sorry)

Edited June 20, 2024 by sa2000
correcting text and including other recommendation

[Luke 39420]

On 6/15/2024 at 6:50 AM, sward said:

So the show was still in the EPG, which is how I was able to launch it manually. I just went into the EPG, located the show and launched it manually. In a previous instance it was still in my recording schedule, because these are ~5 hour recordings, but it just hadn't launched for some reason. I'm wondering if the identifier (in this case e4174aee419d9ccaa970ec33b9ebf24d) for the show changed after the update, which would presumably remove the recording timer. Next time I'll include the logs showing the manual launch, so we can compare identifiers.

HI, yes that would be great. Thanks.

[sward 28]

Hi Luke - I had another missed recording this morning: Emby is scheduled to record Wimbledon every day for the next several days from 6AM to 4PM. It worked fine yesterday, but this morning it didn't even attempt to launch the recording, and there's no record in the log files of any attempt at 6AM this morning. Relevant files are attached. I didn't realize the problem until I finished work at 6PM today, so was unable to check the EPG and launch it manually, but normally I'm able to do that.

embyserver.txt seriestimers.json timers.json

[sa2000 323]

@swardcould you get the logs before the one you attached. We keep 3 days logs so hopefully you can get the earlier ones. Want to see when the guide refreshes happened and if there are any references to the scheduled timer event. It is showing the 2nd July 6am recording as cancelled in the timers.json file - In fact all scheduled recordings for the 2nd July are showing as cancelled. Other wimbledon cancelled scheduled recordings are for the Doubles which I presume you manually cancelled - the timers.json is showing isManual to true and that appears to get set when manually updated to cancel.

is your timezone 4 hours before GMT ?

What do you have in Scheduled Tasks for Refresh Guide? 

View of the timers.json for Wimbledon events

and this is view of 1st July to 3rd July scheduled recordings - all cancelled for the 2nd and isManual set to false - I don't know if the cancellation of the these other recordings is relevant to the Wimbledon schedule entry being marked as cancelled.

Lets see if the earlier logs shed some light. 

[sward 28]

I'm in the EST time zone, which is 4 hrs behind GMT.

You are correct in your assessment that I manually cancelled recordings of doubles matches. Cancellations of any singles matches are done by a bug in the system, not me.

Please find attached the earlier logs showing the guide refresh which happens daily around 4:00AM. For sure we can see the Wimbledon is supposed to start recording at 6:00AM prior to the guide refresh:

2024-07-02 03:58:32.853 Info TaskManager: Daily trigger for Refresh Guide set to fire at 07/02/2024 04:00:00, which is 1.452442385 minutes from now.
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for b4a356fd2f2d564c5e25f2f42c0aef1e, 2024 Wimbledon Championships. Timer will fire in 117.45243843333333 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 5ab5041306cf04c92db740c807bf51a2, 2024 Wimbledon Championships. Timer will fire in 1557.4524382866666 minutes

but after the refresh that scheduled recording mysteriously disappears:

2024-07-02 04:11:13.727 Info HttpClient: GET https://api.themoviedb.org/3/search/tv?api_key=x_secret3_x&query=2024 Wimbledon Championships&language=en-US
2024-07-02 04:11:13.773 Info LiveTV: Creating recording timer for 5ab5041306cf04c92db740c807bf51a2, 2024 Wimbledon Championships. Timer will fire in 1544.7704402983334 minutes
2024-07-02 04:11:13.773 Info LiveTV: Found existing series based on provider ids: 21040039

although as part of the refresh we can see entries for removing old programs, so perhaps this is the process which eliminates shows that are starting shortly (seems to only happen with shows that are ~2 hrs out or less):

2024-07-02 04:06:04.952 Info SqliteItemRepository: Removing 15 old programs from channel 18390095 ESPN HD
 

embyserver-63855492300.txt

[sa2000 323]

23 minutes ago, sward said:

Alhough as part of the refresh we can see entries for removing old programs, so perhaps this is the process which eliminates shows that are starting shortly (seems to only happen with shows that are ~2 hrs out or less):

May be there is a local time / utc adjustment issue. i will have a look and experiment with different timezones and airing times

[sa2000 323]

My tests with timezones and airing times and how close the EPG refresh was to the airing time did not reproduce the problem. 

What I did for testing is run with timezone GMT-4 and have an epg refresh an hour before the airing time and also tried it a few minutes before - the scheduled recording did not get removed.  My test was for a short episode - I do not think the duration is relevant (wimbledon scheduled recording being 10 hours)

Not sure what it is. 

Extracting the relevant log lines from the time b4a356fd2f2d564c5e25f2f42c0aef1e was logged as scheduled to start recording. 

2024-07-02 03:58:32.853 Info TaskManager: Daily trigger for Refresh Guide set to fire at 07/02/2024 04:00:00, which is 1.452442385 minutes from now.
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for b4a356fd2f2d564c5e25f2f42c0aef1e, 2024 Wimbledon Championships. Timer will fire in 117.45243843333333 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 5ab5041306cf04c92db740c807bf51a2, 2024 Wimbledon Championships. Timer will fire in 1557.4524382866666 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 8d384281c3beeaf6e55d1d2c511aabd2, 2024 Wimbledon Championships. Timer will fire in 2997.45243824 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 4b99e910224cb82eb8ab4504c59d19ba, 2024 Wimbledon Championships. Timer will fire in 4437.4524381383335 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 7c8cef90b638e51ce622e3b57b6defdb, 2024 Wimbledon Championships. Timer will fire in 5937.452438086667 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for da6a4c0b0660767f3c48043e68b794ca, 2024 Wimbledon Championships. Timer will fire in 7377.452437698334 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 6579910e5207464719bf7b4b00011fde, 2024 Wimbledon Championships. Timer will fire in 8877.452437676666 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for ed8e827730fa2f02b8bbf257cb9f5d47, 2024 Wimbledon Championships. Timer will fire in 10317.452437543334 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 7d16225fd5471124e18207a25bc2dfea, 2024 Wimbledon Championships. Timer will fire in 11757.452436953334 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 848d5d675e752b23096f5212703e66cf, 2024 Wimbledon Championships. Timer will fire in 13197.452436915 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 28f52dd702d4f0dac8ce64b2396d3b6f, 2024 Wimbledon Championships. Timer will fire in 14637.452436886666 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for 1764f73031c354ce3e1b428a10f20171, 2024 Wimbledon Championships. Timer will fire in 16137.452436863334 minutes
2024-07-02 03:58:32.853 Info LiveTV: Creating recording timer for a5b76dc2876c0469c04b66c87c4c6272, 2024 Wimbledon Championships. Timer will fire in 17577.452436836666 minutes

2024-07-02 04:00:04.185 Info LiveTV: Found epg channel in Emby Guide Data USA-MD67788-X ESPNHD 32645
2024-07-02 04:00:07.545 Info LiveTvManager: Refreshing guide with 14 days of guide data

2024-07-02 04:06:04.229 Info HttpClient: GET https://host4/v1.1/stations/32645/airings?lineupId=USA-MD67788-X&imageAspectTV=2x3&imageText=true&imageSize=Lg&startDateTime=2024-07-02T00:00Z&endDateTime=2024-07-17T00:00Z
2024-07-02 04:06:04.952 Info SqliteItemRepository: Removing 15 old programs from channel 18390095 ESPN HD

2024-07-02 04:11:13.449 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.494 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.658 Info HttpClient: GET https://api4.thetvdb.com/v4/search?type=series&q=2024 Wimbledon Championships

2024-07-02 04:11:13.727 Info TheMovieDb: MovieDbProvider: Finding id for item: 2024 Wimbledon Championships
2024-07-02 04:11:13.727 Info HttpClient: GET https://api.themoviedb.org/3/search/tv?api_key=x_secret3_x&query=2024 Wimbledon Championships&language=en-US

2024-07-02 04:11:13.773 Info LiveTV: Creating recording timer for 5ab5041306cf04c92db740c807bf51a2, 2024 Wimbledon Championships. Timer will fire in 1544.7704402983334 minutes
2024-07-02 04:11:13.773 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.805 Info LiveTV: Creating recording timer for 8d384281c3beeaf6e55d1d2c511aabd2, 2024 Wimbledon Championships. Timer will fire in 2984.769915935 minutes
2024-07-02 04:11:13.805 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.836 Info LiveTV: Creating recording timer for 4b99e910224cb82eb8ab4504c59d19ba, 2024 Wimbledon Championships. Timer will fire in 4424.7693933616665 minutes
2024-07-02 04:11:13.836 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.867 Info LiveTV: Creating recording timer for 7c8cef90b638e51ce622e3b57b6defdb, 2024 Wimbledon Championships. Timer will fire in 5924.76887556 minutes
2024-07-02 04:11:13.867 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.920 Info LiveTV: Creating recording timer for da6a4c0b0660767f3c48043e68b794ca, 2024 Wimbledon Championships. Timer will fire in 7364.767990801667 minutes
2024-07-02 04:11:13.920 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.952 Info LiveTV: Creating recording timer for 6579910e5207464719bf7b4b00011fde, 2024 Wimbledon Championships. Timer will fire in 8864.76745311 minutes
2024-07-02 04:11:13.953 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:13.984 Info LiveTV: Creating recording timer for ed8e827730fa2f02b8bbf257cb9f5d47, 2024 Wimbledon Championships. Timer will fire in 10304.766921266666 minutes
2024-07-02 04:11:13.985 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:14.041 Info LiveTV: Creating recording timer for 7d16225fd5471124e18207a25bc2dfea, 2024 Wimbledon Championships. Timer will fire in 11744.76597872 minutes
2024-07-02 04:11:14.041 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:14.089 Info LiveTV: Creating recording timer for 848d5d675e752b23096f5212703e66cf, 2024 Wimbledon Championships. Timer will fire in 13184.765179191667 minutes
2024-07-02 04:11:14.116 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:14.167 Info LiveTV: Creating recording timer for 28f52dd702d4f0dac8ce64b2396d3b6f, 2024 Wimbledon Championships. Timer will fire in 14624.763873163334 minutes
2024-07-02 04:11:14.167 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:14.200 Info LiveTV: Creating recording timer for 1764f73031c354ce3e1b428a10f20171, 2024 Wimbledon Championships. Timer will fire in 16124.76333014 minutes
2024-07-02 04:11:14.227 Info LiveTV: Found existing series based on provider ids: 21040039

2024-07-02 04:11:14.273 Info LiveTV: Creating recording timer for a5b76dc2876c0469c04b66c87c4c6272, 2024 Wimbledon Championships. Timer will fire in 17564.762115993333 minutes

2024-07-02 04:11:14.853 Info LiveTV: Creating recording timer for 5ab5041306cf04c92db740c807bf51a2, 2024 Wimbledon Championships. Timer will fire in 1544.7524430316666 minutes
2024-07-02 04:11:15.037 Info LiveTV: Creating recording timer for 8d384281c3beeaf6e55d1d2c511aabd2, 2024 Wimbledon Championships. Timer will fire in 2984.749383015 minutes
2024-07-02 04:11:15.832 Info LiveTV: Creating recording timer for 4b99e910224cb82eb8ab4504c59d19ba, 2024 Wimbledon Championships. Timer will fire in 4424.736126813334 minutes
2024-07-02 04:11:16.106 Info LiveTV: Creating recording timer for 7c8cef90b638e51ce622e3b57b6defdb, 2024 Wimbledon Championships. Timer will fire in 5924.73155797 minutes
2024-07-02 04:11:17.160 Info LiveTV: Creating recording timer for da6a4c0b0660767f3c48043e68b794ca, 2024 Wimbledon Championships. Timer will fire in 7364.71400003 minutes
2024-07-02 04:11:17.193 Info LiveTV: Creating recording timer for 6579910e5207464719bf7b4b00011fde, 2024 Wimbledon Championships. Timer will fire in 8864.713437013334 minutes
2024-07-02 04:11:17.913 Info LiveTV: Creating recording timer for ed8e827730fa2f02b8bbf257cb9f5d47, 2024 Wimbledon Championships. Timer will fire in 10304.70143599 minutes
2024-07-02 04:11:24.052 Info LiveTV: Creating recording timer for 7d16225fd5471124e18207a25bc2dfea, 2024 Wimbledon Championships. Timer will fire in 11744.599133368334 minutes
2024-07-02 04:11:24.082 Info LiveTV: Creating recording timer for 848d5d675e752b23096f5212703e66cf, 2024 Wimbledon Championships. Timer will fire in 13184.598617611666 minutes
2024-07-02 04:11:24.147 Info LiveTV: Creating recording timer for 28f52dd702d4f0dac8ce64b2396d3b6f, 2024 Wimbledon Championships. Timer will fire in 14624.597547826666 minutes
2024-07-02 04:11:24.182 Info LiveTV: Creating recording timer for 1764f73031c354ce3e1b428a10f20171, 2024 Wimbledon Championships. Timer will fire in 16124.596958696668 minutes
2024-07-02 04:11:24.273 Info LiveTV: Creating recording timer for a5b76dc2876c0469c04b66c87c4c6272, 2024 Wimbledon Championships. Timer will fire in 17564.59544362 minutes

Your earlier evidence of you manually stating the recording does confirm that it was in the airings schedule. Will discuss with @Luketo see what diagnostics / tests can be done

For the Criminal Minds cancelled scheduled entries I presume it was a cancellation of the whole series recording ? They all show with IsManual set to false.

But for House of Dragons whilst we have Cancelled recordings with isManual set to false - there are a couple that are not cancelled for the 8th and 15th. Could the cancellations be because Emby thinks they are in the library already?

[sward 28]

Let me point out that this bug only surfaces 10-20% of the time with recordings that are close to when the guide refreshes, so it might take a dozen or so tests before you get one failure. For example, Wimbledon recordings launched just fine at 6AM on Monday and today, but not yesterday. Wimbledon is set to run for two weeks straight, so I will let you know of any other failures, but they are not the norm. 

I'm hoping the cancellations of both the Criminal Minds and House of the Dragons episodes are b/c they are already in my library. In any case, I'm not missing any of those episodes, so it seems to be behaving correctly.

[sa2000 323]

2 minutes ago, sward said:

I'm hoping the cancellations of both the Criminal Minds and House of the Dragons episodes are b/c they are already in my library. In any case, I'm not missing any of those episodes, so it seems to be behaving correctly

May be this is relevant to the issue. Emby thinking the 2nd July event was in the library - Could you let me have a copy of the database ?

Could you get me the backup files created for Library.db at 2024-07-02 04:30

Copy out and zip and and upload externally and send me link by Private Message

 

[sward 28]

I sent you the Library.db file as requested. As an FYI, Wimbledon didn't launch automatically this morning, so I had to manually launch the recording, which was easy to do since it was still listed in the EPG. I was also able to verify that the recording timer ID for Wimbledon is the same before and after the guide refresh (8d384281c3beeaf6e55d1d2c511aabd2). I had thought that maybe it changed after the refresh, which could explain why it was being removed from the recording schedule, but that's not happening. The ID stays the same. Relevant logs attached.

embyserver-63855665099.txt embyserver.txt

[sa2000 323]

Just thinking - if it could be because we have the same title for two consecutive airings - 

On 1st and 2nd July - the episode title was "First Round" which was recorded on the 1st July and if we are only checking on episode title then it would be in the library already

On the 3rd and 4th July, the episode title was "Second Round" and I presume it recorded ok on the 3rd 

On the 5th and 6th both will be with title "Third Round" so if my theory holds then the 5th will record but not the 6th

[sa2000 323]

and on the 7th and 8th the title will be "Round of 16"

So I suggest doing the following experiment

Remove the check for it already being in the library and see what happens - 

[sa2000 323]

Wondering if there are more clues in the nfo files for the recordings

[sa2000 323]

On 30/05/2024 at 11:14, sward said:

Strangely there's nothing in the logs regarding this recording, but when I came down at 6:00AM I could still see "2024 Roland-Garros Tennis" listed in the recording schedule for 5AM to 1PM.

Looks similar

The airing had a title "Second Round"

The database shows there would have been already a recording for this title saved the previous day at GMT: Wednesday, 29 May 2024 22:32:17

But .... this is all theory at the moment

[sward 28]

You may be onto something here, and I've attached the nfo files for today and yesterday's recordings (i.e. the "Second Round"). If this was in fact the cause of the problems, I would suggest there's a flaw in the recording logic: if the show/episode is in the recording schedule, it should get recorded. Period. 

I comb through my recording schedule every day to make sure there are no extraneous recordings scheduled, and that no recordings are missing. Therefore I'm totally dependent of the notion that if it's in my recording schedule, it's meant to be recorded.

But for now let's see if deselecting "don't record episodes already in my library" fixes the problem. The "Third Round" airs Friday & Saturday, so if it launches properly on Saturday, you will have diagnosed this correctly.

2024 Wimbledon Championships 2024_07_04_06_00_00 - Second Round.nfo 2024 Wimbledon Championships 2024_07_03_06_00_00 - Second Round.nfo