I am on a FREE plan. I observe that even though I set resolution to be at Minute level, I don't see OnData being called every minute. My logs indicate that many times it's getting called after 6-7 hours. Why is that?

from AlgorithmImports import *
from datetime import *
from Globals import MyGlobals


class IronButterflyAlgorithm(QCAlgorithm):

    last_time_ondata_called: datetime = datetime.min

    def Initialize(self):

        self.SetStartDate(2018, 7, 1)
        self.SetEndDate(2023, 7, 1)
        self.SetCash(100000)

        ticker = "SPY"

        option: Option = self.AddOption(ticker, Resolution.Minute)

        equity_symbol = self.AddEquity(ticker, Resolution.Minute).Symbol

    def OnData(self, slice):
        if self.IsWarmingUp:
            # self.Debug(f"{slice.Time} - Warming up")
            return

        if (self.last_time_ondata_called == datetime.min):
            # first time OnData called
            self.last_time_ondata_called = slice.Time
        else:
            # check for being called after 5 minutes
            if (slice.Time - self.last_time_ondata_called).seconds > (5 * 60):
                self.Debug(
                    f"{slice.Time} OnData being called after {(slice.Time - self.last_time_ondata_called).seconds/60.0} minutes")
            self.last_time_ondata_called = slice.Time

 

Output snippet

434
|
8:54:06
:
2020-02-10 09:31:00 OnData being called after 1051.0 minutes
435
|
8:54:06
:
2020-02-11 09:31:00 OnData being called after 1051.0 minutes
436
|
8:54:10
:
2020-02-12 09:31:00 OnData being called after 1051.0 minutes
437
|
8:54:10
:
2020-02-13 09:31:00 OnData being called after 1051.0 minutes
438
|
8:54:10
:
2020-02-14 09:31:00 OnData being called after 1051.0 minutes
439
|
8:54:10
:
2020-02-18 09:31:00 OnData being called after 1051.0 minutes
440
|
8:54:10
:
2020-02-19 09:31:00 OnData being called after 1051.0 minutes
441
|
8:54:14
:
2020-02-20 09:31:00 OnData being called after 1051.0 minutes
442
|
8:54:14
:
2020-02-21 00:00:00 OnData being called after 480.0 minutes
443
|
8:54:14
:
2020-02-21 09:31:00 OnData being called after 571.0 minutes
444
|
8:54:14
:
2020-02-22 00:00:00 OnData being called after 480.0 minutes
445
|
8:54:14
:
2020-02-24 09:31:00 OnData being called after 571.0 minutes
446
|
8:54:14
:
2020-02-25 09:31:00 OnData being called after 1051.0 minutes
447
|
8:54:17
:
2020-02-26 09:31:00 OnData being called after 1051.0 minutes
448
|
8:54:17
:
2020-02-27 09:31:00 OnData being called after 1051.0 minutes