LUCI Scheduler :: r8 :: win :: 8884035717648076544

Status: SUCCEEDED

Triggered by: -

Duration: 11 hours

Actions:

Definition (rev 87e0f3400b0aac78b81573f56efb8257c68089b2)

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

Incoming triggers

9e447cadfb254c230fff74897745d62940ae361e (1 day ago)
47263752bf8669dd653562b87f1338c0cbd7e1e8 (1 day ago)

Incoming properties

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

Incoming tags

buildset:commit/gitiles/r8.googlesource.com/r8/+/47263752bf8669dd653562b87f1338c0cbd7e1e8
gitiles_ref:refs/heads/main

Debug log (UTC)

[13:25:32.256] New invocation is queued and will start shortly
[13:25:34.914] Starting the invocation (attempt 1)
[13:25:34.944] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/47263752bf8669dd653562b87f1338c0cbd7e1e8"
[13:25:34.944] Popped gitiles commit info from properties and tags
[13:25:34.944] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:25:34.944] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:25:34.944] Buildbucket request:
{
  "requestId": "8884035717648076544",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8884035717648076544",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "9e447cadfb254c230fff74897745d62940ae361e"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@9e447cadfb254c230fff74897745d62940ae361e",
                        "title": "9e447cadfb254c230fff74897745d62940ae361e",
                        "url": "https://r8.googlesource.com/r8/+/9e447cadfb254c230fff74897745d62940ae361e"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "47263752bf8669dd653562b87f1338c0cbd7e1e8"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@47263752bf8669dd653562b87f1338c0cbd7e1e8",
                        "title": "47263752bf8669dd653562b87f1338c0cbd7e1e8",
                        "url": "https://r8.googlesource.com/r8/+/47263752bf8669dd653562b87f1338c0cbd7e1e8"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "47263752bf8669dd653562b87f1338c0cbd7e1e8",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8884035717648076544"
    },
    {
      "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"
  }
}
[13:25:35.408] Scheduled build:
{
  "id": "8718605654123014049",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 685,
  "createdBy": "project:r8",
  "createTime": "2025-04-03T13:25:34.996118464Z",
  "updateTime": "2025-04-03T13:25:34.996118464Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "47263752bf8669dd653562b87f1338c0cbd7e1e8",
      "ref": "refs/heads/main"
    }
  }
}
[13:25:35.408] Task URL: https://cr-buildbucket.appspot.com/build/8718605654123014049
[13:25:35.408] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:2:0) after 8m15s
[13:25:36.425] Received PubSub notification, asking Buildbucket for the build status
[13:25:36.454] Build status: SCHEDULED
[13:33:50.437] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:2:0)
[13:33:50.533] Build status: SCHEDULED
[13:33:50.533] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:4:0) after 9m13s
[13:43:03.558] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:4:0)
[13:43:03.601] Build status: SCHEDULED
[13:43:03.601] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:5:0) after 4m20s
[13:47:23.617] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:5:0)
[13:47:23.639] Build status: SCHEDULED
[13:47:23.639] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:6:0) after 1m25s
[13:48:48.660] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:6:0)
[13:48:48.748] Build status: SCHEDULED
[13:48:48.748] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:7:0) after 4m56s
[13:53:44.772] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:7:0)
[13:53:44.872] Build status: SCHEDULED
[13:53:44.872] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:8:0) after 9m48s
[14:03:32.892] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:8:0)
[14:03:33.065] Build status: SCHEDULED
[14:03:33.065] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:9:0) after 3m46s
[14:07:19.084] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:9:0)
[14:07:19.105] Build status: SCHEDULED
[14:07:19.105] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:10:0) after 1m30s
[14:08:49.126] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:10:0)
[14:08:49.147] Build status: SCHEDULED
[14:08:49.147] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:11:0) after 2m20s
[14:11:09.498] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:11:0)
[14:11:09.539] Build status: SCHEDULED
[14:11:09.539] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:12:0) after 6m5s
[14:17:14.556] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:12:0)
[14:17:14.577] Build status: SCHEDULED
[14:17:14.577] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:13:0) after 5m26s
[14:22:40.597] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:13:0)
[14:22:40.617] Build status: SCHEDULED
[14:22:40.618] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:14:0) after 2m53s
[14:25:33.628] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:14:0)
[14:25:33.645] Build status: SCHEDULED
[14:25:33.645] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:15:0) after 3m40s
[14:29:13.668] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:15:0)
[14:29:13.690] Build status: SCHEDULED
[14:29:13.690] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:16:0) after 6m21s
[14:35:34.707] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:16:0)
[14:35:34.730] Build status: SCHEDULED
[14:35:34.730] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:17:0) after 3m38s
[14:39:12.751] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:17:0)
[14:39:12.768] Build status: SCHEDULED
[14:39:12.768] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:18:0) after 5m23s
[14:44:35.774] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:18:0)
[14:44:35.795] Build status: SCHEDULED
[14:44:35.795] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:19:0) after 8m33s
[14:53:08.810] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:19:0)
[14:53:08.830] Build status: SCHEDULED
[14:53:08.830] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:20:0) after 6m1s
[14:59:09.858] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:20:0)
[14:59:09.872] Build status: SCHEDULED
[14:59:09.872] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:21:0) after 1m40s
[15:00:49.888] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:21:0)
[15:00:49.936] Build status: SCHEDULED
[15:00:49.936] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:22:0) after 9m40s
[15:10:29.990] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:22:0)
[15:10:30.022] Build status: SCHEDULED
[15:10:30.022] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:23:0) after 2m49s
[15:13:19.041] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:23:0)
[15:13:19.063] Build status: SCHEDULED
[15:13:19.063] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:24:0) after 3m52s
[15:17:11.118] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:24:0)
[15:17:11.199] Build status: SCHEDULED
[15:17:11.199] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:25:0) after 8m57s
[15:26:08.261] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:25:0)
[15:26:08.324] Build status: SCHEDULED
[15:26:08.324] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:26:0) after 3m7s
[15:29:15.610] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:26:0)
[15:29:15.632] Build status: SCHEDULED
[15:29:15.632] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:27:0) after 1m30s
[15:30:45.651] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:27:0)
[15:30:45.671] Build status: SCHEDULED
[15:30:45.671] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:28:0) after 2m51s
[15:33:36.692] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:28:0)
[15:33:36.785] Build status: SCHEDULED
[15:33:36.785] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:29:0) after 3m53s
[15:37:29.925] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:29:0)
[15:37:29.950] Build status: SCHEDULED
[15:37:29.950] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:30:0) after 9m15s
[15:46:44.969] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:30:0)
[15:46:44.994] Build status: SCHEDULED
[15:46:44.994] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:31:0) after 7m2s
[15:53:46.994] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:31:0)
[15:53:47.020] Build status: SCHEDULED
[15:53:47.020] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:32:0) after 3m34s
[15:57:21.133] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:32:0)
[15:57:21.155] Build status: SCHEDULED
[15:57:21.155] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:33:0) after 4m20s
[16:01:41.180] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:33:0)
[16:01:41.196] Build status: SCHEDULED
[16:01:41.196] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:34:0) after 7m57s
[16:09:38.243] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:34:0)
[16:09:38.371] Build status: SCHEDULED
[16:09:38.371] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:35:0) after 1m1s
[16:10:39.503] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:35:0)
[16:10:39.529] Build status: SCHEDULED
[16:10:39.529] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:36:0) after 6m33s
[16:17:12.561] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:36:0)
[16:17:12.588] Build status: SCHEDULED
[16:17:12.588] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:37:0) after 3m10s
[16:20:22.621] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:37:0)
[16:20:22.636] Build status: SCHEDULED
[16:20:22.636] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:38:0) after 5m30s
[16:25:52.646] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:38:0)
[16:25:52.691] Build status: SCHEDULED
[16:25:52.691] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:39:0) after 9m55s
[16:27:06.498] Received PubSub notification, asking Buildbucket for the build status
[16:27:06.516] Build status: STARTED
[16:35:47.712] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:39:0)
[16:35:47.729] Build status: STARTED
[16:35:47.729] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:41:0) after 7m24s
[16:43:11.752] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:41:0)
[16:43:11.832] Build status: STARTED
[16:43:11.832] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:42:0) after 8m36s
[16:51:47.864] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:42:0)
[16:51:47.882] Build status: STARTED
[16:51:47.882] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:43:0) after 8m49s
[17:00:37.044] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:43:0)
[17:00:37.059] Build status: STARTED
[17:00:37.059] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:44:0) after 3m9s
[17:03:46.086] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:44:0)
[17:03:46.159] Build status: STARTED
[17:03:46.159] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:45:0) after 5m3s
[17:08:49.167] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:45:0)
[17:08:49.195] Build status: STARTED
[17:08:49.195] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:46:0) after 5m53s
[17:14:42.212] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:46:0)
[17:14:42.245] Build status: STARTED
[17:14:42.245] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:47:0) after 7m5s
[17:21:47.263] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:47:0)
[17:21:47.289] Build status: STARTED
[17:21:47.289] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:48:0) after 5m34s
[17:27:21.316] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:48:0)
[17:27:21.341] Build status: STARTED
[17:27:21.341] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:49:0) after 1m56s
[17:29:17.512] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:49:0)
[17:29:17.539] Build status: STARTED
[17:29:17.540] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:50:0) after 1m29s
[17:30:46.562] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:50:0)
[17:30:46.587] Build status: STARTED
[17:30:46.587] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:51:0) after 7m23s
[17:38:09.616] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:51:0)
[17:38:09.635] Build status: STARTED
[17:38:09.635] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:52:0) after 7m3s
[17:45:12.747] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:52:0)
[17:45:12.763] Build status: STARTED
[17:45:12.763] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:53:0) after 5m43s
[17:50:55.788] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:53:0)
[17:50:55.814] Build status: STARTED
[17:50:55.814] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:54:0) after 6m46s
[17:57:41.811] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:54:0)
[17:57:41.900] Build status: STARTED
[17:57:41.900] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:55:0) after 7m42s
[18:05:23.930] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:55:0)
[18:05:24.001] Build status: STARTED
[18:05:24.001] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:56:0) after 3m47s
[18:09:11.078] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:56:0)
[18:09:11.109] Build status: STARTED
[18:09:11.109] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:57:0) after 3m26s
[18:12:37.103] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:57:0)
[18:12:37.120] Build status: STARTED
[18:12:37.120] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:58:0) after 5m20s
[18:17:57.199] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:58:0)
[18:17:57.229] Build status: STARTED
[18:17:57.229] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:59:0) after 6m58s
[18:24:55.273] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:59:0)
[18:24:55.314] Build status: STARTED
[18:24:55.314] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:60:0) after 2m4s
[18:26:59.374] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:60:0)
[18:26:59.392] Build status: STARTED
[18:26:59.393] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:61:0) after 4m9s
[18:31:08.482] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:61:0)
[18:31:08.519] Build status: STARTED
[18:31:08.519] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:62:0) after 3m1s
[18:34:09.536] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:62:0)
[18:34:09.580] Build status: STARTED
[18:34:09.580] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:63:0) after 5m40s
[18:39:49.601] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:63:0)
[18:39:49.623] Build status: STARTED
[18:39:49.623] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:64:0) after 3m17s
[18:43:06.643] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:64:0)
[18:43:06.673] Build status: STARTED
[18:43:06.673] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:65:0) after 6m51s
[18:49:57.655] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:65:0)
[18:49:57.712] Build status: STARTED
[18:49:57.712] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:66:0) after 4m27s
[18:54:24.728] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:66:0)
[18:54:24.743] Build status: STARTED
[18:54:24.743] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:67:0) after 4m48s
[18:59:13.006] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:67:0)
[18:59:13.028] Build status: STARTED
[18:59:13.028] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:68:0) after 2m2s
[19:01:15.100] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:68:0)
[19:01:15.128] Build status: STARTED
[19:01:15.128] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:69:0) after 8m15s
[19:09:30.182] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:69:0)
[19:09:30.209] Build status: STARTED
[19:09:30.209] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:70:0) after 9m32s
[19:19:02.230] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:70:0)
[19:19:02.260] Build status: STARTED
[19:19:02.260] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:71:0) after 5m38s
[19:24:40.358] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:71:0)
[19:24:40.419] Build status: STARTED
[19:24:40.419] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:72:0) after 8m44s
[19:33:24.505] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:72:0)
[19:33:24.532] Build status: STARTED
[19:33:24.532] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:73:0) after 6m28s
[19:39:52.627] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:73:0)
[19:39:52.673] Build status: STARTED
[19:39:52.673] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:74:0) after 2m9s
[19:42:01.702] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:74:0)
[19:42:01.726] Build status: STARTED
[19:42:01.726] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:75:0) after 9m47s
[19:51:48.849] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:75:0)
[19:51:48.867] Build status: STARTED
[19:51:48.867] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:76:0) after 6m53s
[19:58:41.928] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:76:0)
[19:58:41.981] Build status: STARTED
[19:58:41.981] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:77:0) after 3m47s
[20:02:29.002] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:77:0)
[20:02:29.127] Build status: STARTED
[20:02:29.127] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:78:0) after 3m19s
[20:05:48.206] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:78:0)
[20:05:48.223] Build status: STARTED
[20:05:48.223] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:79:0) after 6m33s
[20:12:21.250] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:79:0)
[20:12:21.275] Build status: STARTED
[20:12:21.275] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:80:0) after 9m9s
[20:21:30.340] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:80:0)
[20:21:30.369] Build status: STARTED
[20:21:30.369] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:81:0) after 6m26s
[20:27:56.428] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:81:0)
[20:27:56.483] Build status: STARTED
[20:27:56.483] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:82:0) after 1m3s
[20:28:59.557] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:82:0)
[20:28:59.583] Build status: STARTED
[20:28:59.583] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:83:0) after 3m39s
[20:32:38.609] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:83:0)
[20:32:38.625] Build status: STARTED
[20:32:38.625] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:84:0) after 9m28s
[20:42:06.693] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:84:0)
[20:42:06.728] Build status: STARTED
[20:42:06.728] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:85:0) after 4m38s
[20:46:44.909] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:85:0)
[20:46:44.958] Build status: STARTED
[20:46:44.958] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:86:0) after 9m48s
[20:56:32.967] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:86:0)
[20:56:33.030] Build status: STARTED
[20:56:33.030] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:87:0) after 3m10s
[20:59:43.051] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:87:0)
[20:59:43.122] Build status: STARTED
[20:59:43.122] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:88:0) after 8m13s
[21:07:56.194] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:88:0)
[21:07:56.291] Build status: STARTED
[21:07:56.291] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:89:0) after 5m56s
[21:13:52.337] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:89:0)
[21:13:52.374] Build status: STARTED
[21:13:52.374] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:90:0) after 8m3s
[21:21:55.552] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:90:0)
[21:21:55.568] Build status: STARTED
[21:21:55.568] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:91:0) after 3m47s
[21:25:42.623] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:91:0)
[21:25:42.641] Build status: STARTED
[21:25:42.641] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:92:0) after 6m27s
[21:32:09.763] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:92:0)
[21:32:09.789] Build status: STARTED
[21:32:09.789] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:93:0) after 8m9s
[21:40:18.865] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:93:0)
[21:40:18.881] Build status: STARTED
[21:40:18.881] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:94:0) after 6m3s
[21:46:22.083] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:94:0)
[21:46:22.114] Build status: STARTED
[21:46:22.114] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:95:0) after 2m55s
[21:49:17.127] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:95:0)
[21:49:17.154] Build status: STARTED
[21:49:17.154] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:96:0) after 3m15s
[21:52:32.177] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:96:0)
[21:52:32.215] Build status: STARTED
[21:52:32.215] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:97:0) after 6m30s
[21:59:02.238] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:97:0)
[21:59:02.269] Build status: STARTED
[21:59:02.269] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:98:0) after 4m10s
[22:03:12.294] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:98:0)
[22:03:12.322] Build status: STARTED
[22:03:12.322] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:99:0) after 8m33s
[22:11:45.341] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:99:0)
[22:11:45.426] Build status: STARTED
[22:11:45.426] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:100:0) after 4m4s
[22:15:49.470] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:100:0)
[22:15:49.487] Build status: STARTED
[22:15:49.487] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:101:0) after 2m14s
[22:18:03.602] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:101:0)
[22:18:03.630] Build status: STARTED
[22:18:03.630] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:102:0) after 4m57s
[22:23:00.708] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:102:0)
[22:23:00.738] Build status: STARTED
[22:23:00.738] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:103:0) after 2m33s
[22:25:33.721] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:103:0)
[22:25:33.738] Build status: STARTED
[22:25:33.738] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:104:0) after 9m26s
[22:34:59.759] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:104:0)
[22:34:59.791] Build status: STARTED
[22:34:59.791] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:105:0) after 8m12s
[22:43:11.876] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:105:0)
[22:43:11.921] Build status: STARTED
[22:43:11.921] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:106:0) after 7m52s
[22:51:03.992] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:106:0)
[22:51:04.022] Build status: STARTED
[22:51:04.022] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:107:0) after 8m4s
[22:59:08.115] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:107:0)
[22:59:08.145] Build status: STARTED
[22:59:08.145] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:108:0) after 3m52s
[23:03:00.155] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:108:0)
[23:03:00.186] Build status: STARTED
[23:03:00.186] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:109:0) after 3m9s
[23:06:09.239] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:109:0)
[23:06:09.265] Build status: STARTED
[23:06:09.265] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:110:0) after 7m51s
[23:14:00.314] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:110:0)
[23:14:00.336] Build status: STARTED
[23:14:00.336] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:111:0) after 8m59s
[23:22:59.359] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:111:0)
[23:22:59.408] Build status: STARTED
[23:22:59.409] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:112:0) after 6m6s
[23:29:05.481] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:112:0)
[23:29:05.512] Build status: STARTED
[23:29:05.512] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:113:0) after 4m29s
[23:33:34.541] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:113:0)
[23:33:34.643] Build status: STARTED
[23:33:34.643] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:114:0) after 4m55s
[23:38:29.707] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:114:0)
[23:38:29.771] Build status: STARTED
[23:38:29.771] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:115:0) after 9m5s
[23:47:34.795] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:115:0)
[23:47:34.822] Build status: STARTED
[23:47:34.822] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:116:0) after 6m38s
[23:54:12.847] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:116:0)
[23:54:12.864] Build status: STARTED
[23:54:12.864] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:117:0) after 5m52s
[00:00:04.896] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:117:0)
[00:00:04.955] Build status: STARTED
[00:00:04.955] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:118:0) after 6m56s
[00:07:00.979] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:118:0)
[00:07:01.003] Build status: STARTED
[00:07:01.003] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:119:0) after 9m48s
[00:16:49.022] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:119:0)
[00:16:49.089] Build status: STARTED
[00:16:49.089] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:120:0) after 5m45s
[00:22:34.111] Handling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:120:0)
[00:22:34.133] Build status: STARTED
[00:22:34.133] Scheduling timer "check-buildbucket-build-status" (r8/win:8884035717648076544:121:0) after 9m9s
[00:26:29.812] Received PubSub notification, asking Buildbucket for the build status
[00:26:29.840] Build:
{
  "id": "8718605654123014049",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 685,
  "createdBy": "project:r8",
  "createTime": "2025-04-03T13:25:34.996118464Z",
  "startTime": "2025-04-03T16:27:06.301006337Z",
  "endTime": "2025-04-04T00:26:29.563958559Z",
  "updateTime": "2025-04-04T00:26:29.563958559Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "47263752bf8669dd653562b87f1338c0cbd7e1e8",
      "ref": "refs/heads/main"
    }
  }
}
[00:26:29.840] Invocation finished in 11h0m57.588879632s with status SUCCEEDED