LUCI Scheduler :: r8 :: win :: 8901633366623183264

Status: SUCCEEDED

Triggered by: -

Duration: 7 hours

Actions:

Definition (rev 87e0f3400b0aac78b81573f56efb8257c68089b2)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "ci"
  builder: "win"
>

Incoming triggers

8837d9f411d3eabe6db48400d95a37fd4985b1d9 (5 months ago)

Incoming properties

{
  "branch": "refs/heads/main",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "8837d9f411d3eabe6db48400d95a37fd4985b1d9"
}

Incoming tags

buildset:commit/gitiles/r8.googlesource.com/r8/+/8837d9f411d3eabe6db48400d95a37fd4985b1d9
gitiles_ref:refs/heads/main

Debug log (UTC)

[07:38:26.406] New invocation is queued and will start shortly
[07:38:27.452] Starting the invocation (attempt 1)
[07:38:27.476] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/8837d9f411d3eabe6db48400d95a37fd4985b1d9"
[07:38:27.477] Popped gitiles commit info from properties and tags
[07:38:27.477] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:38:27.477] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:38:27.477] Buildbucket request:
{
  "requestId": "8901633366623183264",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8901633366623183264",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "8837d9f411d3eabe6db48400d95a37fd4985b1d9"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@8837d9f411d3eabe6db48400d95a37fd4985b1d9",
                        "title": "8837d9f411d3eabe6db48400d95a37fd4985b1d9",
                        "url": "https://r8.googlesource.com/r8/+/8837d9f411d3eabe6db48400d95a37fd4985b1d9"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "8837d9f411d3eabe6db48400d95a37fd4985b1d9",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8901633366623183264"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/win"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[07:38:28.112] Scheduled build:
{
  "id": "8736203304758858769",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 248,
  "createdBy": "project:r8",
  "createTime": "2024-09-21T07:38:27.556051737Z",
  "updateTime": "2024-09-21T07:38:27.556051737Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "8837d9f411d3eabe6db48400d95a37fd4985b1d9",
      "ref": "refs/heads/main"
    }
  }
}
[07:38:28.112] Task URL: https://cr-buildbucket.appspot.com/build/8736203304758858769
[07:38:28.112] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:2:0) after 1m44s
[07:38:29.015] Received PubSub notification, asking Buildbucket for the build status
[07:38:29.033] Build status: SCHEDULED
[07:40:12.198] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:2:0)
[07:40:12.233] Build status: SCHEDULED
[07:40:12.233] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:4:0) after 7m24s
[07:47:36.345] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:4:0)
[07:47:36.364] Build status: SCHEDULED
[07:47:36.364] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:5:0) after 2m5s
[07:49:41.378] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:5:0)
[07:49:41.601] Build status: SCHEDULED
[07:49:41.601] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:6:0) after 5m39s
[07:55:20.624] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:6:0)
[07:55:20.683] Build status: SCHEDULED
[07:55:20.683] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:7:0) after 8m24s
[08:03:45.028] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:7:0)
[08:03:45.055] Build status: SCHEDULED
[08:03:45.055] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:8:0) after 7m11s
[08:10:56.076] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:8:0)
[08:10:56.105] Build status: SCHEDULED
[08:10:56.105] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:9:0) after 3m21s
[08:14:17.121] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:9:0)
[08:14:17.210] Build status: SCHEDULED
[08:14:17.210] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:10:0) after 7m34s
[08:21:51.276] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:10:0)
[08:21:51.394] Build status: SCHEDULED
[08:21:51.394] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:11:0) after 6m59s
[08:28:50.410] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:11:0)
[08:28:50.429] Build status: SCHEDULED
[08:28:50.429] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:12:0) after 3m34s
[08:32:24.460] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:12:0)
[08:32:24.477] Build status: SCHEDULED
[08:32:24.477] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:13:0) after 9m32s
[08:41:56.491] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:13:0)
[08:41:56.522] Build status: SCHEDULED
[08:41:56.522] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:14:0) after 5m21s
[08:47:17.641] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:14:0)
[08:47:17.659] Build status: SCHEDULED
[08:47:17.659] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:15:0) after 3m1s
[08:50:18.674] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:15:0)
[08:50:18.696] Build status: SCHEDULED
[08:50:18.696] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:16:0) after 7m32s
[08:57:50.695] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:16:0)
[08:57:50.718] Build status: SCHEDULED
[08:57:50.718] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:17:0) after 9m57s
[09:07:47.735] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:17:0)
[09:07:47.754] Build status: SCHEDULED
[09:07:47.754] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:18:0) after 5m5s
[09:12:52.780] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:18:0)
[09:12:52.800] Build status: SCHEDULED
[09:12:52.800] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:19:0) after 2m55s
[09:15:48.020] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:19:0)
[09:15:48.061] Build status: SCHEDULED
[09:15:48.061] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:20:0) after 2m43s
[09:18:31.211] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:20:0)
[09:18:31.231] Build status: SCHEDULED
[09:18:31.232] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:21:0) after 8m13s
[09:26:44.248] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:21:0)
[09:26:44.289] Build status: SCHEDULED
[09:26:44.289] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:22:0) after 7m30s
[09:34:14.400] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:22:0)
[09:34:14.422] Build status: SCHEDULED
[09:34:14.422] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:23:0) after 6m54s
[09:38:22.928] Received PubSub notification, asking Buildbucket for the build status
[09:38:22.946] Build status: STARTED
[09:41:08.435] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:23:0)
[09:41:08.452] Build status: STARTED
[09:41:08.452] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:25:0) after 9m52s
[09:51:00.466] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:25:0)
[09:51:00.545] Build status: STARTED
[09:51:00.545] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:26:0) after 3m53s
[09:54:53.654] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:26:0)
[09:54:53.679] Build status: STARTED
[09:54:53.679] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:27:0) after 7m48s
[10:02:41.820] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:27:0)
[10:02:41.839] Build status: STARTED
[10:02:41.839] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:28:0) after 2m48s
[10:05:29.855] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:28:0)
[10:05:29.876] Build status: STARTED
[10:05:29.876] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:29:0) after 4m28s
[10:09:58.109] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:29:0)
[10:09:58.131] Build status: STARTED
[10:09:58.131] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:30:0) after 4m18s
[10:14:16.247] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:30:0)
[10:14:16.265] Build status: STARTED
[10:14:16.265] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:31:0) after 7m2s
[10:21:18.350] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:31:0)
[10:21:18.375] Build status: STARTED
[10:21:18.375] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:32:0) after 9m37s
[10:30:55.503] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:32:0)
[10:30:55.596] Build status: STARTED
[10:30:55.596] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:33:0) after 8m1s
[10:38:56.612] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:33:0)
[10:38:56.632] Build status: STARTED
[10:38:56.632] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:34:0) after 3m19s
[10:42:15.652] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:34:0)
[10:42:15.673] Build status: STARTED
[10:42:15.673] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:35:0) after 1m33s
[10:43:48.688] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:35:0)
[10:43:48.706] Build status: STARTED
[10:43:48.706] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:36:0) after 8m6s
[10:51:54.822] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:36:0)
[10:51:54.838] Build status: STARTED
[10:51:54.838] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:37:0) after 8m50s
[11:00:44.853] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:37:0)
[11:00:44.888] Build status: STARTED
[11:00:44.888] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:38:0) after 5m56s
[11:06:40.922] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:38:0)
[11:06:40.942] Build status: STARTED
[11:06:40.942] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:39:0) after 6m11s
[11:12:51.959] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:39:0)
[11:12:51.981] Build status: STARTED
[11:12:51.981] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:40:0) after 6m46s
[11:19:38.303] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:40:0)
[11:19:38.322] Build status: STARTED
[11:19:38.322] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:41:0) after 4m36s
[11:24:14.338] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:41:0)
[11:24:14.355] Build status: STARTED
[11:24:14.355] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:42:0) after 1m20s
[11:25:34.771] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:42:0)
[11:25:34.802] Build status: STARTED
[11:25:34.802] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:43:0) after 9m27s
[11:35:01.941] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:43:0)
[11:35:01.959] Build status: STARTED
[11:35:01.959] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:44:0) after 7m0s
[11:42:02.046] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:44:0)
[11:42:02.239] Build status: STARTED
[11:42:02.239] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:45:0) after 9m17s
[11:51:19.255] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:45:0)
[11:51:19.298] Build status: STARTED
[11:51:19.298] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:46:0) after 6m36s
[11:57:55.314] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:46:0)
[11:57:55.379] Build status: STARTED
[11:57:55.379] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:47:0) after 6m15s
[12:04:10.461] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:47:0)
[12:04:10.508] Build status: STARTED
[12:04:10.509] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:48:0) after 6m37s
[12:10:47.788] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:48:0)
[12:10:47.807] Build status: STARTED
[12:10:47.807] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:49:0) after 9m33s
[12:20:20.824] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:49:0)
[12:20:20.857] Build status: STARTED
[12:20:20.857] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:50:0) after 4m19s
[12:24:39.878] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:50:0)
[12:24:39.897] Build status: STARTED
[12:24:39.897] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:51:0) after 1m10s
[12:25:49.970] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:51:0)
[12:25:50.047] Build status: STARTED
[12:25:50.047] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:52:0) after 6m13s
[12:32:03.854] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:52:0)
[12:32:03.929] Build status: STARTED
[12:32:03.929] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:53:0) after 9m0s
[12:41:03.947] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:53:0)
[12:41:03.967] Build status: STARTED
[12:41:03.967] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:54:0) after 4m54s
[12:45:58.117] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:54:0)
[12:45:58.147] Build status: STARTED
[12:45:58.147] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:55:0) after 7m39s
[12:53:37.264] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:55:0)
[12:53:37.282] Build status: STARTED
[12:53:37.282] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:56:0) after 3m50s
[12:57:27.294] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:56:0)
[12:57:27.316] Build status: STARTED
[12:57:27.316] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:57:0) after 8m6s
[13:05:33.332] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:57:0)
[13:05:33.350] Build status: STARTED
[13:05:33.350] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:58:0) after 6m46s
[13:12:19.504] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:58:0)
[13:12:19.525] Build status: STARTED
[13:12:19.525] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:59:0) after 8m29s
[13:20:48.568] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:59:0)
[13:20:48.590] Build status: STARTED
[13:20:48.590] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:60:0) after 6m28s
[13:27:16.608] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:60:0)
[13:27:16.695] Build status: STARTED
[13:27:16.695] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:61:0) after 4m27s
[13:31:43.712] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:61:0)
[13:31:43.730] Build status: STARTED
[13:31:43.730] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:62:0) after 9m50s
[13:41:33.749] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:62:0)
[13:41:33.780] Build status: STARTED
[13:41:33.780] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:63:0) after 2m1s
[13:43:34.933] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:63:0)
[13:43:35.011] Build status: STARTED
[13:43:35.011] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:64:0) after 1m57s
[13:45:32.029] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:64:0)
[13:45:32.057] Build status: STARTED
[13:45:32.057] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:65:0) after 1m23s
[13:46:55.072] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:65:0)
[13:46:55.098] Build status: STARTED
[13:46:55.098] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:66:0) after 1m8s
[13:48:03.130] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:66:0)
[13:48:03.150] Build status: STARTED
[13:48:03.151] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:67:0) after 3m5s
[13:51:08.332] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:67:0)
[13:51:08.430] Build status: STARTED
[13:51:08.430] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:68:0) after 1m43s
[13:52:51.609] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:68:0)
[13:52:51.631] Build status: STARTED
[13:52:51.631] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:69:0) after 9m24s
[14:02:15.691] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:69:0)
[14:02:15.815] Build status: STARTED
[14:02:15.815] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:70:0) after 4m15s
[14:06:30.904] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:70:0)
[14:06:30.927] Build status: STARTED
[14:06:30.927] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:71:0) after 6m33s
[14:13:03.953] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:71:0)
[14:13:03.972] Build status: STARTED
[14:13:03.972] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:72:0) after 4m36s
[14:17:39.988] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:72:0)
[14:17:40.007] Build status: STARTED
[14:17:40.007] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:73:0) after 2m37s
[14:20:17.035] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:73:0)
[14:20:17.087] Build status: STARTED
[14:20:17.088] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:74:0) after 1m57s
[14:22:14.108] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:74:0)
[14:22:14.128] Build status: STARTED
[14:22:14.128] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:75:0) after 7m39s
[14:29:53.250] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:75:0)
[14:29:53.269] Build status: STARTED
[14:29:53.269] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:76:0) after 3m22s
[14:33:15.288] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:76:0)
[14:33:15.309] Build status: STARTED
[14:33:15.309] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:77:0) after 4m45s
[14:38:00.337] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:77:0)
[14:38:00.510] Build status: STARTED
[14:38:00.511] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:78:0) after 2m27s
[14:40:27.531] Handling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:78:0)
[14:40:27.549] Build status: STARTED
[14:40:27.549] Scheduling timer "check-buildbucket-build-status" (r8/win:8901633366623183264:79:0) after 8m50s
[14:43:29.162] Received PubSub notification, asking Buildbucket for the build status
[14:43:29.230] Build:
{
  "id": "8736203304758858769",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 248,
  "createdBy": "project:r8",
  "createTime": "2024-09-21T07:38:27.556051737Z",
  "startTime": "2024-09-21T09:38:22.747777170Z",
  "endTime": "2024-09-21T14:43:28.914888609Z",
  "updateTime": "2024-09-21T14:43:28.914888609Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "8837d9f411d3eabe6db48400d95a37fd4985b1d9",
      "ref": "refs/heads/main"
    }
  }
}
[14:43:29.230] Invocation finished in 7h5m2.836058396s with status SUCCEEDED