Guide error causes IceTV server to delete currently recording timer

[grumpy_geoff]

Guide events (Perth) -
Motorsport: Supercars
'2022 - Sydney Motorsport Park - Day 2'
7mate HD, 9:00am, Sun, 6 Mar 2022, 60 minutes
The Repco Supercar Championship opens the Season at Sydney Motorsport Park. Day 2 features, Touring Car Masters, TGRA86, Dunlop Series, Supercars (including Top Ten Shootout and Race 2), and Aussie Race Cars.
----
Motorsport: Supercars
'2022 - Sydney Motorsport Park - Day 2'
7HD, 10:00am, Sun, 6 Mar 2022, 120 minutes
The Repco Supercar Championship opens the Season at Sydney Motorsport Park. Day 2 features, Touring Car Masters, TGRA86, Dunlop Series, Supercars (including Top Ten Shootout and Race 2), and Aussie Race Cars.
----
Motorsport: Supercars
'2022 - Sydney Motorsport Park - Day 2'
7HD, 12:00pm, Sun, 6 Mar 2022, 120 minutes
The Repco Supercar Championship opens the Season at Sydney Motorsport Park. Day 2 features, Touring Car Masters, TGRA86, Dunlop Series, Supercars (including Top Ten Shootout and Race 2), and Aussie Race Cars.

I had 3 x recording timers set; for 9am, 10am, 12pm.

At 10:21, my Beyonwiz fetches the guide and timers from IceTV.
It receives an instruction to delete the 10am timer (ice_timer_id: 16786887589105021639)
The current recording timer is then stopped by my Beyonwiz.

I didn't get to record the start of the race!

Did someone at IceTV alter the 10am entry to give it the exact same subtitle and description as the 12pm entry, thus making it a "repeat"?

edit -
I'm sure the 12pm timer (ice_timer_id: 16786887589105021640) was deleted by IceTV also.

[aeb001]

is this why i too dont have todays supercars? i walked in at 2:40 QLD & saw I had missed 40 minutes of it. second time this has happened in last 2 weeks

[aeb001]

also the titles got renamed from day 2 preview to just day to. also the highlights tonight & monday etc have also all been renamed.

[aeb001]

@lisa @tiphanee @jennifer
Possibly the same thing happening with Wheeler Dealers - 'This Horse Needs to Be Put Out of Its Misery' - 9Rush Gold Coast, 7:30pm, Sun, 6 Mar 2022, 60 minutes

[grumpy_geoff]

is this why i too dont have todays supercars? i walked in at 2:40 QLD & saw I had missed 40 minutes of it. second time this has happened in last 2 weeks

I think you missed more than that - the race started @ 11:33am AWST (13:33 AEST).

[aeb001]

The day 2 preview + 15 mins buffer so i got a few laps. by the time i got the record on at 2:40 qld it was lap 44.

[aeb001]

Daniel, This is the one i mentioned to you in the support message

[Daniel Hall at IceTV]

Hi grumpy_geoff,

I have enabled logging on your account if something like this comes up again we will have much more information.

[grumpy_geoff]

Hi grumpy_geoff,

I have enabled logging on your account if something like this comes up again we will have much more information.

Laugh!  You need to audit "morning checks".
"Oh look, the same program name is being shown 3 times across 2 different services - 2 of them are bound to be repeats, I'll mark the latter 2 as repeats".
Morning check - http://forum.icetv.com.au/iceforum/index.php?topic=7055.msg36766#msg36766

[MD]

The comment "Laugh" is rude and my company does not need you to tell us how to audit our "morning checks".

I don't believe you have the faintest idea of the size of the job to manually cross check individual shows across every region in Australia whilst being subject of unreliable data from the broadcasters. You may well pick on one error that we miss as it effects you so you are aware of it but you are one of thousands of customers of which the vast majority have no issues as they don't watch that specific show.  Check "Wheeler Dealers" against our "Most Popular" ranking on our website or app to see how far down it lists and ask yourself where we have to expend our time chasing anomalies, which are limited by the size of the company staff and affordable hours to be worked.

If we say that we need to enable logging on your PVR it means that the error is not found elsewhere so we are cross checking to get to its source.  Be pleased we invest the time to do so.

[grumpy_geoff]

Fair enough, but your guide staff need to be aware of what impact their "fixes" in the "morning checks" will do to existing timers on end-user's PVRs.
That is, after all, the raison d'etre of IceTV - With IceTV's "Intelligent Content Engine" Never Miss Enjoying a Good Show Again.

A scant one-line reply 4 weeks after I posted the issue, with no further details/information, gave me no confidence.
How is auditing timers being deleted from my PVR by IceTV's scheduling engine going to identify the issue?  It's a guide issue after all.  First run episodes were incorrectly marked as repeats during a "morning check".

The "Wheeler Dealers" program doesn't come into it.  I made no reference to it.

The facts are -
I had 3 x timers scheduled by IceTV for 3 different guide events.
They were present on the PVR for many days.

Code Select Expand

{600}<  101.832> [RecordTimer] Record RecordTimerEntry(name=Motorsport: Supercars, begin=Sun Mar  6 08:55:00 2022, end=Sun Mar  6 10:24:00 2022, serviceref=1:0:19:567:506:1013:EEEE0000:0:0:0:, justplay=0, isAutoTimer=0, ice_timer_id=16786604893149628107)
{600}<  101.838> [RecordTimer] Record RecordTimerEntry(name=Motorsport: Supercars, begin=Sun Mar  6 09:55:00 2022, end=Sun Mar  6 12:24:00 2022, serviceref=1:0:19:564:506:1013:EEEE0000:0:0:0:, justplay=0, isAutoTimer=0, ice_timer_id=16786887589105021639)
{600}<  101.844> [RecordTimer] Record RecordTimerEntry(name=Motorsport: Supercars, begin=Sun Mar  6 11:55:00 2022, end=Sun Mar  6 14:24:00 2022, serviceref=1:0:19:564:506:1013:EEEE0000:0:0:0:, justplay=0, isAutoTimer=0, ice_timer_id=16786887589105021640)
They were still there at the ~10am fetch -
{957}< 11803.502> [IceTV] 2022-03-06 10:06:34: Start update
{957}< 11803.823> [EPGFetcher] fetch batch size: 30
{957}< 11804.090> [IceTV] 2022-03-06 10:06:34: Timers updated OK
{957}< 11804.499> [IceTV] 2022-03-06 10:06:35: EPG download OK
{957}< 11804.501> [IceTV] 2022-03-06 10:06:35: End update

... but 15 mins later
IceTV sent a delete for the timer recording at 09:55:00, which was already running so it was stopped by the PVR (timerid 16786887589105021639).
IceTV also sent a delete for the timer recording at 11:55:00 (16786887589105021640).

Code Select Expand

{956}< 12703.502> [IceTV] 2022-03-06 10:21:34: Start update
{956}< 12703.820> [EPGFetcher] fetch batch size: 30
{956}< 12704.083> [RecordTimer] Sun Mar  6 10:21:34 2022 activating state 3
{956}< 12704.084> [RecordTimer] Sun Mar  6 10:21:34 2022 stop recording from: Tuner B
...
{956}< 12704.581> [RecordTimer] Sun Mar  6 10:21:35 2022 record time changed, start prepare is now: Sun Mar  6 10:21:15 2022
{13469}< 12704.743> [IceTV] DELETE http://api.icetv.com.au/shows/timers/16786887589105021639?email_address={snipped}
{13469}< 12704.744> [IceTV] headers {'Content-Length': '2', 'Accept-Encoding': 'gzip, deflate', 'Accept': 'application/json', 'User-Agent': 'SystemPlugins.IceTV/20211007 (Beyonwiz; T4; 20211010)', 'Connection': 'keep-alive', 'Content-Type': 'application/json'}
{13469}< 12704.744> [IceTV] {}
{13469}< 12704.745> [IceTV] 404 Not Found
{13469}< 12704.745> [IceTV] headers {'Access-Control-Allow-Methods': 'GET, POST, PUT, DELETE', 'X-Powered-By': 'CppCMS/1.0.3', 'Transfer-Encoding': 'chunked', 'Content-Encoding': 'gzip', 'Server': 'nginx/1.20.2', 'Connection': 'keep-alive', 'Access-Control-Allow-Credentials': 'true', 'Date': 'Sun, 06 Mar 2022 02:21:35 GMT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Allow-Headers': 'origin, content-type, accept', 'Content-Type': 'application/json; charset=utf-8'}
{13469}< 12704.746> [IceTV]
{13469}< 12704.748> [IceTV] 2022-03-06 10:21:35: Can not delete timer: 404 Client Error: Not Found for url: http://api.icetv.com.au/shows/timers/16786887589105021639?email_address={snipped}
{956}< 12704.794> [IceTV] 2022-03-06 10:21:35: Timers updated OK
{956}< 12705.190> [IceTV] 2022-03-06 10:21:36: EPG download OK
{956}< 12705.211> [IceTV] 2022-03-06 10:21:36: End update
{957}< 12705.213> [IceTV] 2022-03-06 10:21:36: Timer deleted OK