LUCI Scheduler :: r8 :: win :: 8879850008591516864

Status: SUCCEEDED

Triggered by: -

Duration: 14 hours

Actions:

Definition (rev 87e0f3400b0aac78b81573f56efb8257c68089b2)

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

Incoming triggers

1bbdaa07486734ce1d31d93fecc28ce701c81052 (1 month ago)
b7014ba5b217625f529e66c1693fc3e16aed747c (1 month ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[18:15:35.483] New invocation is queued and will start shortly
[18:15:37.207] Starting the invocation (attempt 1)
[18:15:37.235] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/b7014ba5b217625f529e66c1693fc3e16aed747c"
[18:15:37.235] Popped gitiles commit info from properties and tags
[18:15:37.235] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:15:37.235] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:15:37.235] Buildbucket request:
{
  "requestId": "8879850008591516864",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8879850008591516864",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "1bbdaa07486734ce1d31d93fecc28ce701c81052"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@1bbdaa07486734ce1d31d93fecc28ce701c81052",
                        "title": "1bbdaa07486734ce1d31d93fecc28ce701c81052",
                        "url": "https://r8.googlesource.com/r8/+/1bbdaa07486734ce1d31d93fecc28ce701c81052"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "b7014ba5b217625f529e66c1693fc3e16aed747c"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@b7014ba5b217625f529e66c1693fc3e16aed747c",
                        "title": "b7014ba5b217625f529e66c1693fc3e16aed747c",
                        "url": "https://r8.googlesource.com/r8/+/b7014ba5b217625f529e66c1693fc3e16aed747c"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "b7014ba5b217625f529e66c1693fc3e16aed747c",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8879850008591516864"
    },
    {
      "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"
  }
}
[18:15:37.674] Scheduled build:
{
  "id": "8714419946032833489",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 775,
  "createdBy": "project:r8",
  "createTime": "2025-05-19T18:15:37.298176903Z",
  "updateTime": "2025-05-19T18:15:37.298176903Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "b7014ba5b217625f529e66c1693fc3e16aed747c",
      "ref": "refs/heads/main"
    }
  }
}
[18:15:37.674] Task URL: https://cr-buildbucket.appspot.com/build/8714419946032833489
[18:15:37.674] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:2:0) after 7m52s
[18:15:37.880] Received PubSub notification, asking Buildbucket for the build status
[18:15:37.908] Build status: SCHEDULED
[18:23:29.698] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:2:0)
[18:23:29.730] Build status: SCHEDULED
[18:23:29.730] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:4:0) after 8m15s
[18:31:44.907] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:4:0)
[18:31:44.941] Build status: SCHEDULED
[18:31:44.941] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:5:0) after 9m41s
[18:41:25.969] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:5:0)
[18:41:25.995] Build status: SCHEDULED
[18:41:25.995] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:6:0) after 6m45s
[18:48:11.165] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:6:0)
[18:48:11.191] Build status: SCHEDULED
[18:48:11.191] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:7:0) after 5m52s
[18:54:03.217] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:7:0)
[18:54:03.302] Build status: SCHEDULED
[18:54:03.302] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:8:0) after 4m29s
[18:58:32.369] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:8:0)
[18:58:32.633] Build status: SCHEDULED
[18:58:32.633] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:9:0) after 2m40s
[19:01:12.661] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:9:0)
[19:01:12.695] Build status: SCHEDULED
[19:01:12.695] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:10:0) after 5m29s
[19:06:41.755] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:10:0)
[19:06:41.782] Build status: SCHEDULED
[19:06:41.782] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:11:0) after 3m7s
[19:09:49.140] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:11:0)
[19:09:49.168] Build status: SCHEDULED
[19:09:49.168] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:12:0) after 5m30s
[19:15:19.266] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:12:0)
[19:15:19.309] Build status: SCHEDULED
[19:15:19.309] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:13:0) after 4m17s
[19:19:36.336] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:13:0)
[19:19:36.360] Build status: SCHEDULED
[19:19:36.360] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:14:0) after 6m40s
[19:26:16.384] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:14:0)
[19:26:16.417] Build status: SCHEDULED
[19:26:16.417] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:15:0) after 1m36s
[19:27:52.421] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:15:0)
[19:27:52.493] Build status: SCHEDULED
[19:27:52.493] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:16:0) after 3m46s
[19:31:38.553] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:16:0)
[19:31:38.590] Build status: SCHEDULED
[19:31:38.590] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:17:0) after 2m11s
[19:33:49.580] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:17:0)
[19:33:49.598] Build status: SCHEDULED
[19:33:49.598] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:18:0) after 1m56s
[19:35:45.617] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:18:0)
[19:35:45.648] Build status: SCHEDULED
[19:35:45.648] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:19:0) after 1m18s
[19:37:03.678] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:19:0)
[19:37:03.713] Build status: SCHEDULED
[19:37:03.713] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:20:0) after 6m19s
[19:43:22.748] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:20:0)
[19:43:22.767] Build status: SCHEDULED
[19:43:22.767] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:21:0) after 7m56s
[19:51:18.794] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:21:0)
[19:51:18.822] Build status: SCHEDULED
[19:51:18.822] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:22:0) after 6m17s
[19:57:35.889] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:22:0)
[19:57:35.929] Build status: SCHEDULED
[19:57:35.929] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:23:0) after 6m43s
[20:04:18.959] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:23:0)
[20:04:18.984] Build status: SCHEDULED
[20:04:18.984] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:24:0) after 2m2s
[20:06:21.029] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:24:0)
[20:06:21.077] Build status: SCHEDULED
[20:06:21.077] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:25:0) after 3m39s
[20:10:00.089] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:25:0)
[20:10:00.119] Build status: SCHEDULED
[20:10:00.119] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:26:0) after 8m1s
[20:18:01.197] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:26:0)
[20:18:01.300] Build status: SCHEDULED
[20:18:01.300] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:27:0) after 4m52s
[20:22:53.324] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:27:0)
[20:22:53.345] Build status: SCHEDULED
[20:22:53.345] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:28:0) after 6m43s
[20:29:36.442] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:28:0)
[20:29:36.465] Build status: SCHEDULED
[20:29:36.465] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:29:0) after 2m9s
[20:31:45.523] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:29:0)
[20:31:45.542] Build status: SCHEDULED
[20:31:45.542] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:30:0) after 3m56s
[20:35:41.615] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:30:0)
[20:35:41.673] Build status: SCHEDULED
[20:35:41.673] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:31:0) after 9m23s
[20:45:04.740] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:31:0)
[20:45:04.759] Build status: SCHEDULED
[20:45:04.759] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:32:0) after 8m40s
[20:53:44.731] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:32:0)
[20:53:44.839] Build status: SCHEDULED
[20:53:44.839] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:33:0) after 6m29s
[21:00:13.923] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:33:0)
[21:00:13.938] Build status: SCHEDULED
[21:00:13.938] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:34:0) after 9m58s
[21:10:12.169] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:34:0)
[21:10:12.245] Build status: SCHEDULED
[21:10:12.245] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:35:0) after 7m59s
[21:18:11.258] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:35:0)
[21:18:11.331] Build status: SCHEDULED
[21:18:11.331] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:36:0) after 6m23s
[21:24:34.408] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:36:0)
[21:24:34.427] Build status: SCHEDULED
[21:24:34.427] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:37:0) after 2m16s
[21:26:50.506] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:37:0)
[21:26:50.526] Build status: SCHEDULED
[21:26:50.526] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:38:0) after 7m5s
[21:33:55.640] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:38:0)
[21:33:55.662] Build status: SCHEDULED
[21:33:55.662] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:39:0) after 8m1s
[21:41:56.726] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:39:0)
[21:41:56.905] Build status: SCHEDULED
[21:41:56.905] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:40:0) after 6m31s
[21:48:27.954] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:40:0)
[21:48:27.972] Build status: SCHEDULED
[21:48:27.972] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:41:0) after 6m37s
[21:55:05.053] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:41:0)
[21:55:05.072] Build status: SCHEDULED
[21:55:05.072] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:42:0) after 2m15s
[21:57:20.071] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:42:0)
[21:57:20.145] Build status: SCHEDULED
[21:57:20.145] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:43:0) after 7m8s
[22:04:28.215] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:43:0)
[22:04:28.234] Build status: SCHEDULED
[22:04:28.234] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:44:0) after 5m6s
[22:09:34.299] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:44:0)
[22:09:34.332] Build status: SCHEDULED
[22:09:34.332] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:45:0) after 9m46s
[22:19:20.449] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:45:0)
[22:19:20.516] Build status: SCHEDULED
[22:19:20.516] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:46:0) after 4m42s
[22:24:02.571] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:46:0)
[22:24:02.594] Build status: SCHEDULED
[22:24:02.594] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:47:0) after 9m18s
[22:33:20.613] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:47:0)
[22:33:20.637] Build status: SCHEDULED
[22:33:20.637] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:48:0) after 1m27s
[22:34:47.847] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:48:0)
[22:34:47.868] Build status: SCHEDULED
[22:34:47.868] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:49:0) after 5m45s
[22:40:32.891] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:49:0)
[22:40:32.992] Build status: SCHEDULED
[22:40:32.992] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:50:0) after 5m34s
[22:46:07.102] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:50:0)
[22:46:07.125] Build status: SCHEDULED
[22:46:07.125] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:51:0) after 1m4s
[22:47:11.134] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:51:0)
[22:47:11.169] Build status: SCHEDULED
[22:47:11.169] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:52:0) after 4m59s
[22:52:10.240] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:52:0)
[22:52:10.259] Build status: SCHEDULED
[22:52:10.259] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:53:0) after 7m15s
[22:59:25.272] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:53:0)
[22:59:25.292] Build status: SCHEDULED
[22:59:25.292] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:54:0) after 3m7s
[23:02:32.315] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:54:0)
[23:02:32.344] Build status: SCHEDULED
[23:02:32.344] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:55:0) after 1m29s
[23:04:01.360] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:55:0)
[23:04:01.381] Build status: SCHEDULED
[23:04:01.381] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:56:0) after 4m29s
[23:08:30.488] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:56:0)
[23:08:30.633] Build status: SCHEDULED
[23:08:30.633] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:57:0) after 3m41s
[23:12:11.654] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:57:0)
[23:12:11.743] Build status: SCHEDULED
[23:12:11.743] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:58:0) after 7m2s
[23:19:13.767] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:58:0)
[23:19:13.784] Build status: SCHEDULED
[23:19:13.784] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:59:0) after 8m11s
[23:27:24.822] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:59:0)
[23:27:24.856] Build status: SCHEDULED
[23:27:24.856] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:60:0) after 9m22s
[23:36:46.876] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:60:0)
[23:36:47.038] Build status: SCHEDULED
[23:36:47.038] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:61:0) after 3m28s
[23:40:15.127] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:61:0)
[23:40:15.151] Build status: SCHEDULED
[23:40:15.151] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:62:0) after 9m59s
[23:50:14.187] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:62:0)
[23:50:14.206] Build status: SCHEDULED
[23:50:14.207] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:63:0) after 6m26s
[23:56:40.224] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:63:0)
[23:56:40.250] Build status: SCHEDULED
[23:56:40.250] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:64:0) after 2m0s
[23:58:40.420] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:64:0)
[23:58:40.473] Build status: SCHEDULED
[23:58:40.473] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:65:0) after 6m4s
[00:04:44.542] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:65:0)
[00:04:44.623] Build status: SCHEDULED
[00:04:44.623] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:66:0) after 7m0s
[00:11:44.622] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:66:0)
[00:11:44.643] Build status: SCHEDULED
[00:11:44.643] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:67:0) after 7m18s
[00:19:02.716] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:67:0)
[00:19:02.784] Build status: SCHEDULED
[00:19:02.785] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:68:0) after 2m49s
[00:21:51.873] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:68:0)
[00:21:51.895] Build status: SCHEDULED
[00:21:51.895] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:69:0) after 3m37s
[00:25:29.034] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:69:0)
[00:25:29.086] Build status: SCHEDULED
[00:25:29.086] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:70:0) after 3m16s
[00:28:45.142] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:70:0)
[00:28:45.176] Build status: SCHEDULED
[00:28:45.176] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:71:0) after 7m19s
[00:36:04.194] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:71:0)
[00:36:04.223] Build status: SCHEDULED
[00:36:04.223] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:72:0) after 7m31s
[00:43:35.244] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:72:0)
[00:43:35.334] Build status: SCHEDULED
[00:43:35.334] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:73:0) after 7m2s
[00:50:37.357] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:73:0)
[00:50:37.384] Build status: SCHEDULED
[00:50:37.384] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:74:0) after 9m59s
[01:00:36.415] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:74:0)
[01:00:36.431] Build status: SCHEDULED
[01:00:36.431] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:75:0) after 4m53s
[01:05:29.535] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:75:0)
[01:05:29.556] Build status: SCHEDULED
[01:05:29.556] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:76:0) after 9m23s
[01:14:52.707] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:76:0)
[01:14:52.725] Build status: SCHEDULED
[01:14:52.725] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:77:0) after 4m58s
[01:19:50.763] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:77:0)
[01:19:50.797] Build status: SCHEDULED
[01:19:50.797] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:78:0) after 7m24s
[01:27:14.870] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:78:0)
[01:27:14.913] Build status: SCHEDULED
[01:27:14.913] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:79:0) after 4m29s
[01:31:44.034] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:79:0)
[01:31:44.066] Build status: SCHEDULED
[01:31:44.066] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:80:0) after 3m41s
[01:35:25.088] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:80:0)
[01:35:25.109] Build status: SCHEDULED
[01:35:25.109] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:81:0) after 8m39s
[01:41:12.472] Received PubSub notification, asking Buildbucket for the build status
[01:41:12.491] Build status: STARTED
[01:44:04.124] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:81:0)
[01:44:04.206] Build status: STARTED
[01:44:04.206] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:83:0) after 3m39s
[01:47:43.222] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:83:0)
[01:47:43.250] Build status: STARTED
[01:47:43.250] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:84:0) after 6m57s
[01:54:40.387] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:84:0)
[01:54:40.476] Build status: STARTED
[01:54:40.476] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:85:0) after 6m11s
[02:00:51.548] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:85:0)
[02:00:51.570] Build status: STARTED
[02:00:51.570] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:86:0) after 7m52s
[02:08:43.591] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:86:0)
[02:08:43.635] Build status: STARTED
[02:08:43.635] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:87:0) after 1m23s
[02:10:06.726] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:87:0)
[02:10:06.840] Build status: STARTED
[02:10:06.840] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:88:0) after 9m9s
[02:19:15.870] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:88:0)
[02:19:15.926] Build status: STARTED
[02:19:15.926] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:89:0) after 5m6s
[02:24:21.985] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:89:0)
[02:24:22.004] Build status: STARTED
[02:24:22.004] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:90:0) after 3m32s
[02:27:54.022] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:90:0)
[02:27:54.046] Build status: STARTED
[02:27:54.046] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:91:0) after 2m47s
[02:30:41.070] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:91:0)
[02:30:41.094] Build status: STARTED
[02:30:41.094] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:92:0) after 7m44s
[02:38:25.111] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:92:0)
[02:38:25.140] Build status: STARTED
[02:38:25.140] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:93:0) after 1m25s
[02:39:50.196] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:93:0)
[02:39:50.215] Build status: STARTED
[02:39:50.215] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:94:0) after 4m30s
[02:44:20.258] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:94:0)
[02:44:20.288] Build status: STARTED
[02:44:20.288] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:95:0) after 1m43s
[02:46:03.357] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:95:0)
[02:46:03.377] Build status: STARTED
[02:46:03.377] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:96:0) after 3m49s
[02:49:52.400] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:96:0)
[02:49:52.426] Build status: STARTED
[02:49:52.426] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:97:0) after 3m48s
[02:53:40.486] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:97:0)
[02:53:40.507] Build status: STARTED
[02:53:40.507] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:98:0) after 1m24s
[02:55:04.531] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:98:0)
[02:55:04.550] Build status: STARTED
[02:55:04.550] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:99:0) after 9m46s
[03:04:50.686] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:99:0)
[03:04:50.717] Build status: STARTED
[03:04:50.717] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:100:0) after 9m39s
[03:14:29.739] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:100:0)
[03:14:29.789] Build status: STARTED
[03:14:29.789] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:101:0) after 3m21s
[03:17:50.811] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:101:0)
[03:17:50.839] Build status: STARTED
[03:17:50.840] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:102:0) after 6m30s
[03:24:20.864] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:102:0)
[03:24:20.891] Build status: STARTED
[03:24:20.891] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:103:0) after 7m5s
[03:31:25.916] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:103:0)
[03:31:25.975] Build status: STARTED
[03:31:25.975] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:104:0) after 5m2s
[03:36:27.975] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:104:0)
[03:36:28.005] Build status: STARTED
[03:36:28.005] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:105:0) after 6m45s
[03:43:13.078] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:105:0)
[03:43:13.111] Build status: STARTED
[03:43:13.111] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:106:0) after 1m36s
[03:44:49.180] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:106:0)
[03:44:49.205] Build status: STARTED
[03:44:49.205] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:107:0) after 3m2s
[03:47:51.269] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:107:0)
[03:47:51.298] Build status: STARTED
[03:47:51.298] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:108:0) after 3m57s
[03:51:48.322] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:108:0)
[03:51:48.344] Build status: STARTED
[03:51:48.344] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:109:0) after 4m33s
[03:56:21.420] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:109:0)
[03:56:21.449] Build status: STARTED
[03:56:21.449] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:110:0) after 7m39s
[04:04:00.570] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:110:0)
[04:04:00.602] Build status: STARTED
[04:04:00.602] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:111:0) after 1m19s
[04:05:19.618] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:111:0)
[04:05:19.633] Build status: STARTED
[04:05:19.633] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:112:0) after 9m26s
[04:14:45.705] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:112:0)
[04:14:45.723] Build status: STARTED
[04:14:45.723] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:113:0) after 4m30s
[04:19:15.757] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:113:0)
[04:19:15.784] Build status: STARTED
[04:19:15.784] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:114:0) after 2m25s
[04:21:40.838] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:114:0)
[04:21:40.896] Build status: STARTED
[04:21:40.896] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:115:0) after 3m2s
[04:24:42.920] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:115:0)
[04:24:43.022] Build status: STARTED
[04:24:43.022] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:116:0) after 9m55s
[04:34:38.052] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:116:0)
[04:34:38.158] Build status: STARTED
[04:34:38.158] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:117:0) after 2m30s
[04:37:08.183] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:117:0)
[04:37:08.203] Build status: STARTED
[04:37:08.203] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:118:0) after 3m38s
[04:40:46.372] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:118:0)
[04:40:46.392] Build status: STARTED
[04:40:46.393] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:119:0) after 4m10s
[04:44:56.515] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:119:0)
[04:44:56.544] Build status: STARTED
[04:44:56.544] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:120:0) after 4m40s
[04:49:36.568] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:120:0)
[04:49:36.599] Build status: STARTED
[04:49:36.599] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:121:0) after 1m2s
[04:50:38.627] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:121:0)
[04:50:38.646] Build status: STARTED
[04:50:38.646] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:122:0) after 7m6s
[04:57:44.720] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:122:0)
[04:57:44.741] Build status: STARTED
[04:57:44.742] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:123:0) after 5m42s
[05:03:26.771] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:123:0)
[05:03:26.812] Build status: STARTED
[05:03:26.812] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:124:0) after 7m55s
[05:11:21.834] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:124:0)
[05:11:21.865] Build status: STARTED
[05:11:21.865] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:125:0) after 2m39s
[05:14:00.890] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:125:0)
[05:14:01.020] Build status: STARTED
[05:14:01.020] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:126:0) after 1m40s
[05:15:41.140] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:126:0)
[05:15:41.158] Build status: STARTED
[05:15:41.158] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:127:0) after 7m47s
[05:23:28.186] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:127:0)
[05:23:28.209] Build status: STARTED
[05:23:28.209] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:128:0) after 2m59s
[05:26:27.283] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:128:0)
[05:26:27.318] Build status: STARTED
[05:26:27.318] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:129:0) after 4m27s
[05:30:54.532] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:129:0)
[05:30:54.550] Build status: STARTED
[05:30:54.550] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:130:0) after 1m37s
[05:32:31.575] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:130:0)
[05:32:31.605] Build status: STARTED
[05:32:31.605] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:131:0) after 5m38s
[05:38:10.045] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:131:0)
[05:38:10.066] Build status: STARTED
[05:38:10.066] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:132:0) after 2m35s
[05:40:45.125] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:132:0)
[05:40:45.148] Build status: STARTED
[05:40:45.148] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:133:0) after 6m38s
[05:47:23.281] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:133:0)
[05:47:23.310] Build status: STARTED
[05:47:23.310] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:134:0) after 1m17s
[05:48:40.445] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:134:0)
[05:48:40.481] Build status: STARTED
[05:48:40.481] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:135:0) after 4m55s
[05:53:35.629] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:135:0)
[05:53:35.654] Build status: STARTED
[05:53:35.655] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:136:0) after 1m51s
[05:55:26.673] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:136:0)
[05:55:26.707] Build status: STARTED
[05:55:26.707] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:137:0) after 6m59s
[06:02:26.023] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:137:0)
[06:02:26.045] Build status: STARTED
[06:02:26.045] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:138:0) after 3m59s
[06:06:25.118] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:138:0)
[06:06:25.151] Build status: STARTED
[06:06:25.151] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:139:0) after 5m38s
[06:12:03.420] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:139:0)
[06:12:03.478] Build status: STARTED
[06:12:03.478] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:140:0) after 4m27s
[06:16:30.500] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:140:0)
[06:16:30.528] Build status: STARTED
[06:16:30.528] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:141:0) after 6m40s
[06:23:10.546] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:141:0)
[06:23:10.565] Build status: STARTED
[06:23:10.565] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:142:0) after 8m29s
[06:31:39.991] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:142:0)
[06:31:40.006] Build status: STARTED
[06:31:40.006] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:143:0) after 6m16s
[06:37:56.022] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:143:0)
[06:37:56.049] Build status: STARTED
[06:37:56.049] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:144:0) after 1m19s
[06:39:15.158] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:144:0)
[06:39:15.216] Build status: STARTED
[06:39:15.216] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:145:0) after 4m2s
[06:43:17.231] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:145:0)
[06:43:17.249] Build status: STARTED
[06:43:17.249] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:146:0) after 2m26s
[06:45:43.267] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:146:0)
[06:45:43.290] Build status: STARTED
[06:45:43.290] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:147:0) after 1m11s
[06:46:54.320] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:147:0)
[06:46:54.341] Build status: STARTED
[06:46:54.342] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:148:0) after 5m2s
[06:51:56.373] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:148:0)
[06:51:56.424] Build status: STARTED
[06:51:56.424] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:149:0) after 4m33s
[06:56:29.423] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:149:0)
[06:56:29.445] Build status: STARTED
[06:56:29.445] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:150:0) after 4m19s
[07:00:48.460] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:150:0)
[07:00:48.482] Build status: STARTED
[07:00:48.482] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:151:0) after 2m17s
[07:03:05.506] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:151:0)
[07:03:05.521] Build status: STARTED
[07:03:05.521] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:152:0) after 8m51s
[07:11:56.547] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:152:0)
[07:11:56.570] Build status: STARTED
[07:11:56.571] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:153:0) after 5m57s
[07:17:53.599] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:153:0)
[07:17:53.708] Build status: STARTED
[07:17:53.709] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:154:0) after 7m54s
[07:25:47.829] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:154:0)
[07:25:47.847] Build status: STARTED
[07:25:47.847] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:155:0) after 3m8s
[07:28:55.868] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:155:0)
[07:28:55.884] Build status: STARTED
[07:28:55.884] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:156:0) after 8m12s
[07:37:07.901] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:156:0)
[07:37:07.924] Build status: STARTED
[07:37:07.925] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:157:0) after 4m11s
[07:41:18.945] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:157:0)
[07:41:18.965] Build status: STARTED
[07:41:18.965] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:158:0) after 7m52s
[07:49:11.392] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:158:0)
[07:49:11.417] Build status: STARTED
[07:49:11.417] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:159:0) after 3m30s
[07:52:41.734] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:159:0)
[07:52:41.754] Build status: STARTED
[07:52:41.754] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:160:0) after 6m18s
[07:58:59.736] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:160:0)
[07:58:59.876] Build status: STARTED
[07:58:59.876] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:161:0) after 2m40s
[08:01:39.999] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:161:0)
[08:01:40.112] Build status: STARTED
[08:01:40.112] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:162:0) after 4m6s
[08:05:46.155] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:162:0)
[08:05:46.171] Build status: STARTED
[08:05:46.171] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:163:0) after 4m2s
[08:09:48.163] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:163:0)
[08:09:48.182] Build status: STARTED
[08:09:48.182] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:164:0) after 6m19s
[08:16:07.260] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:164:0)
[08:16:07.279] Build status: STARTED
[08:16:07.279] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:165:0) after 6m38s
[08:22:45.305] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:165:0)
[08:22:45.321] Build status: STARTED
[08:22:45.321] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:166:0) after 7m43s
[08:30:28.345] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:166:0)
[08:30:28.361] Build status: STARTED
[08:30:28.361] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:167:0) after 1m24s
[08:31:52.392] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:167:0)
[08:31:52.410] Build status: STARTED
[08:31:52.410] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:168:0) after 7m56s
[08:39:48.451] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:168:0)
[08:39:48.476] Build status: STARTED
[08:39:48.476] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:169:0) after 9m14s
[08:49:02.959] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:169:0)
[08:49:02.984] Build status: STARTED
[08:49:02.984] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:170:0) after 5m10s
[08:54:13.038] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:170:0)
[08:54:13.065] Build status: STARTED
[08:54:13.065] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:171:0) after 3m1s
[08:57:14.149] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:171:0)
[08:57:14.173] Build status: STARTED
[08:57:14.173] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:172:0) after 2m10s
[08:59:24.247] Handling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:172:0)
[08:59:24.447] Build status: STARTED
[08:59:24.447] Scheduling timer "check-buildbucket-build-status" (r8/win:8879850008591516864:173:0) after 4m12s
[09:01:53.451] Received PubSub notification, asking Buildbucket for the build status
[09:01:53.469] Build:
{
  "id": "8714419946032833489",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 775,
  "createdBy": "project:r8",
  "createTime": "2025-05-19T18:15:37.298176903Z",
  "startTime": "2025-05-20T01:41:00.693296376Z",
  "endTime": "2025-05-20T09:01:52.561362602Z",
  "updateTime": "2025-05-20T09:01:52.561362602Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "b7014ba5b217625f529e66c1693fc3e16aed747c",
      "ref": "refs/heads/main"
    }
  }
}
[09:01:53.469] Invocation finished in 14h46m17.994489896s with status SUCCEEDED