Status: FAILED
Triggered by: -
Duration: 8 hours
Actions:

Definition (rev 87e0f3400b0aac78b81573f56efb8257c68089b2)

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

Incoming triggers

Incoming properties

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

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/45140f080ca3520dc530eab514758b0339ebd1d2
  • gitiles_ref:refs/heads/main

Debug log (UTC)

[18:28:23.843] New invocation is queued and will start shortly
[18:28:24.914] Starting the invocation (attempt 1)
[18:28:24.940] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/45140f080ca3520dc530eab514758b0339ebd1d2"
[18:28:24.940] Popped gitiles commit info from properties and tags
[18:28:24.940] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:24.940] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:24.940] Buildbucket request:
{
  "requestId": "8910289783613865440",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8910289783613865440",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "4c2fae05e796fc21fe82109c390363d03be2cdd4"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@4c2fae05e796fc21fe82109c390363d03be2cdd4",
                        "title": "4c2fae05e796fc21fe82109c390363d03be2cdd4",
                        "url": "https://r8.googlesource.com/r8/+/4c2fae05e796fc21fe82109c390363d03be2cdd4"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "3ae55f576822c843c153222b34c5118bdf5597b6"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3ae55f576822c843c153222b34c5118bdf5597b6",
                        "title": "3ae55f576822c843c153222b34c5118bdf5597b6",
                        "url": "https://r8.googlesource.com/r8/+/3ae55f576822c843c153222b34c5118bdf5597b6"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "45140f080ca3520dc530eab514758b0339ebd1d2"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@45140f080ca3520dc530eab514758b0339ebd1d2",
                        "title": "45140f080ca3520dc530eab514758b0339ebd1d2",
                        "url": "https://r8.googlesource.com/r8/+/45140f080ca3520dc530eab514758b0339ebd1d2"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "45140f080ca3520dc530eab514758b0339ebd1d2",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8910289783613865440"
    },
    {
      "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:28:25.449] Scheduled build:
{
  "id": "8744859721742787569",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 42,
  "createdBy": "project:r8",
  "createTime": "2024-06-17T18:28:25.006356666Z",
  "updateTime": "2024-06-17T18:28:25.006356666Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "45140f080ca3520dc530eab514758b0339ebd1d2",
      "ref": "refs/heads/main"
    }
  }
}
[18:28:25.449] Task URL: https://cr-buildbucket.appspot.com/build/8744859721742787569
[18:28:25.449] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:2:0) after 1m3s
[18:28:26.396] Received PubSub notification, asking Buildbucket for the build status
[18:28:26.422] Build status: SCHEDULED
[18:29:28.463] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:2:0)
[18:29:28.495] Build status: SCHEDULED
[18:29:28.495] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:4:0) after 8m32s
[18:38:00.510] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:4:0)
[18:38:00.538] Build status: SCHEDULED
[18:38:00.538] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:5:0) after 8m40s
[18:46:40.559] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:5:0)
[18:46:40.610] Build status: SCHEDULED
[18:46:40.610] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:6:0) after 8m6s
[18:54:47.172] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:6:0)
[18:54:47.209] Build status: SCHEDULED
[18:54:47.209] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:7:0) after 2m18s
[18:57:05.334] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:7:0)
[18:57:05.393] Build status: SCHEDULED
[18:57:05.393] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:8:0) after 5m2s
[19:02:07.412] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:8:0)
[19:02:07.428] Build status: SCHEDULED
[19:02:07.428] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:9:0) after 7m17s
[19:09:24.547] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:9:0)
[19:09:24.566] Build status: SCHEDULED
[19:09:24.566] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:10:0) after 6m48s
[19:16:12.530] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:10:0)
[19:16:12.655] Build status: SCHEDULED
[19:16:12.655] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:11:0) after 2m46s
[19:18:58.719] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:11:0)
[19:18:58.912] Build status: SCHEDULED
[19:18:58.912] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:12:0) after 8m19s
[19:27:17.927] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:12:0)
[19:27:17.948] Build status: SCHEDULED
[19:27:17.948] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:13:0) after 6m28s
[19:33:45.967] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:13:0)
[19:33:45.986] Build status: SCHEDULED
[19:33:45.986] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:14:0) after 5m25s
[19:39:11.007] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:14:0)
[19:39:11.025] Build status: SCHEDULED
[19:39:11.025] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:15:0) after 9m8s
[19:48:19.096] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:15:0)
[19:48:19.125] Build status: SCHEDULED
[19:48:19.125] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:16:0) after 3m39s
[19:51:58.142] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:16:0)
[19:51:58.168] Build status: SCHEDULED
[19:51:58.168] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:17:0) after 2m28s
[19:54:26.182] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:17:0)
[19:54:26.220] Build status: SCHEDULED
[19:54:26.220] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:18:0) after 7m37s
[20:02:03.243] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:18:0)
[20:02:03.270] Build status: SCHEDULED
[20:02:03.270] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:19:0) after 3m16s
[20:05:19.318] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:19:0)
[20:05:19.337] Build status: SCHEDULED
[20:05:19.337] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:20:0) after 5m25s
[20:10:44.353] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:20:0)
[20:10:44.374] Build status: SCHEDULED
[20:10:44.374] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:21:0) after 6m23s
[20:17:07.452] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:21:0)
[20:17:07.470] Build status: SCHEDULED
[20:17:07.470] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:22:0) after 9m25s
[20:26:32.586] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:22:0)
[20:26:32.643] Build status: SCHEDULED
[20:26:32.643] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:23:0) after 3m25s
[20:29:57.676] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:23:0)
[20:29:57.718] Build status: SCHEDULED
[20:29:57.718] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:24:0) after 7m38s
[20:37:35.736] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:24:0)
[20:37:35.760] Build status: SCHEDULED
[20:37:35.760] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:25:0) after 3m9s
[20:40:44.854] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:25:0)
[20:40:44.874] Build status: SCHEDULED
[20:40:44.874] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:26:0) after 4m40s
[20:45:24.910] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:26:0)
[20:45:24.952] Build status: SCHEDULED
[20:45:24.952] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:27:0) after 4m4s
[20:46:23.199] Received PubSub notification, asking Buildbucket for the build status
[20:46:23.221] Build status: STARTED
[20:49:29.038] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:27:0)
[20:49:29.058] Build status: STARTED
[20:49:29.059] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:29:0) after 3m31s
[20:53:00.137] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:29:0)
[20:53:00.206] Build status: STARTED
[20:53:00.206] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:30:0) after 3m40s
[20:56:40.222] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:30:0)
[20:56:40.310] Build status: STARTED
[20:56:40.310] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:31:0) after 8m39s
[21:05:19.509] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:31:0)
[21:05:19.562] Build status: STARTED
[21:05:19.562] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:32:0) after 7m30s
[21:12:49.588] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:32:0)
[21:12:49.621] Build status: STARTED
[21:12:49.621] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:33:0) after 8m8s
[21:20:57.640] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:33:0)
[21:20:57.658] Build status: STARTED
[21:20:57.658] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:34:0) after 5m32s
[21:26:29.740] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:34:0)
[21:26:29.818] Build status: STARTED
[21:26:29.818] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:35:0) after 5m10s
[21:31:39.895] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:35:0)
[21:31:39.932] Build status: STARTED
[21:31:39.932] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:36:0) after 5m27s
[21:37:06.982] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:36:0)
[21:37:07.004] Build status: STARTED
[21:37:07.004] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:37:0) after 2m4s
[21:39:11.103] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:37:0)
[21:39:11.123] Build status: STARTED
[21:39:11.123] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:38:0) after 6m21s
[21:45:32.153] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:38:0)
[21:45:32.243] Build status: STARTED
[21:45:32.243] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:39:0) after 4m4s
[21:49:36.336] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:39:0)
[21:49:36.363] Build status: STARTED
[21:49:36.363] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:40:0) after 4m36s
[21:54:12.392] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:40:0)
[21:54:12.410] Build status: STARTED
[21:54:12.410] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:41:0) after 6m24s
[22:00:36.432] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:41:0)
[22:00:36.488] Build status: STARTED
[22:00:36.488] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:42:0) after 4m12s
[22:04:48.520] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:42:0)
[22:04:48.622] Build status: STARTED
[22:04:48.622] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:43:0) after 4m7s
[22:08:55.621] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:43:0)
[22:08:55.639] Build status: STARTED
[22:08:55.639] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:44:0) after 9m16s
[22:18:11.673] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:44:0)
[22:18:11.693] Build status: STARTED
[22:18:11.693] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:45:0) after 2m25s
[22:20:36.706] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:45:0)
[22:20:36.879] Build status: STARTED
[22:20:36.879] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:46:0) after 9m29s
[22:30:05.901] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:46:0)
[22:30:05.967] Build status: STARTED
[22:30:05.967] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:47:0) after 6m21s
[22:36:26.981] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:47:0)
[22:36:26.998] Build status: STARTED
[22:36:26.998] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:48:0) after 7m11s
[22:43:38.026] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:48:0)
[22:43:38.070] Build status: STARTED
[22:43:38.070] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:49:0) after 7m27s
[22:51:05.305] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:49:0)
[22:51:05.325] Build status: STARTED
[22:51:05.325] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:50:0) after 1m51s
[22:52:56.338] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:50:0)
[22:52:56.413] Build status: STARTED
[22:52:56.413] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:51:0) after 2m30s
[22:55:26.440] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:51:0)
[22:55:26.470] Build status: STARTED
[22:55:26.470] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:52:0) after 7m25s
[23:02:51.536] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:52:0)
[23:02:51.555] Build status: STARTED
[23:02:51.555] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:53:0) after 6m37s
[23:09:28.635] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:53:0)
[23:09:28.654] Build status: STARTED
[23:09:28.654] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:54:0) after 6m5s
[23:15:33.748] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:54:0)
[23:15:33.772] Build status: STARTED
[23:15:33.772] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:55:0) after 5m27s
[23:21:00.792] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:55:0)
[23:21:00.810] Build status: STARTED
[23:21:00.810] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:56:0) after 9m58s
[23:30:58.828] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:56:0)
[23:30:58.850] Build status: STARTED
[23:30:58.850] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:57:0) after 5m51s
[23:36:49.880] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:57:0)
[23:36:49.904] Build status: STARTED
[23:36:49.904] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:58:0) after 6m40s
[23:43:30.051] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:58:0)
[23:43:30.073] Build status: STARTED
[23:43:30.073] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:59:0) after 4m44s
[23:48:14.163] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:59:0)
[23:48:14.240] Build status: STARTED
[23:48:14.240] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:60:0) after 7m51s
[23:56:05.288] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:60:0)
[23:56:05.306] Build status: STARTED
[23:56:05.306] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:61:0) after 4m39s
[00:00:44.323] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:61:0)
[00:00:44.343] Build status: STARTED
[00:00:44.343] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:62:0) after 1m42s
[00:02:26.467] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:62:0)
[00:02:26.708] Build status: STARTED
[00:02:26.708] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:63:0) after 4m52s
[00:07:18.849] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:63:0)
[00:07:18.878] Build status: STARTED
[00:07:18.878] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:64:0) after 5m29s
[00:12:48.103] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:64:0)
[00:12:48.122] Build status: STARTED
[00:12:48.122] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:65:0) after 3m42s
[00:16:30.354] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:65:0)
[00:16:30.377] Build status: STARTED
[00:16:30.377] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:66:0) after 9m48s
[00:26:18.437] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:66:0)
[00:26:18.457] Build status: STARTED
[00:26:18.457] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:67:0) after 7m30s
[00:33:48.442] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:67:0)
[00:33:48.495] Build status: STARTED
[00:33:48.495] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:68:0) after 1m50s
[00:35:38.539] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:68:0)
[00:35:38.556] Build status: STARTED
[00:35:38.556] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:69:0) after 3m39s
[00:39:17.627] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:69:0)
[00:39:17.645] Build status: STARTED
[00:39:17.645] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:70:0) after 3m8s
[00:42:25.663] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:70:0)
[00:42:25.691] Build status: STARTED
[00:42:25.691] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:71:0) after 9m17s
[00:51:42.716] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:71:0)
[00:51:42.738] Build status: STARTED
[00:51:42.738] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:72:0) after 6m31s
[00:58:14.450] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:72:0)
[00:58:14.469] Build status: STARTED
[00:58:14.469] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:73:0) after 2m6s
[01:00:20.491] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:73:0)
[01:00:20.520] Build status: STARTED
[01:00:20.520] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:74:0) after 8m55s
[01:09:16.069] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:74:0)
[01:09:16.097] Build status: STARTED
[01:09:16.097] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:75:0) after 8m33s
[01:17:49.143] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:75:0)
[01:17:49.170] Build status: STARTED
[01:17:49.170] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:76:0) after 5m58s
[01:23:47.192] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:76:0)
[01:23:47.229] Build status: STARTED
[01:23:47.229] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:77:0) after 2m1s
[01:25:48.255] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:77:0)
[01:25:48.280] Build status: STARTED
[01:25:48.280] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:78:0) after 9m32s
[01:35:20.303] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:78:0)
[01:35:20.323] Build status: STARTED
[01:35:20.323] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:79:0) after 6m47s
[01:42:07.466] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:79:0)
[01:42:07.490] Build status: STARTED
[01:42:07.490] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:80:0) after 9m30s
[01:51:37.505] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:80:0)
[01:51:37.522] Build status: STARTED
[01:51:37.522] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:81:0) after 9m20s
[02:00:57.693] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:81:0)
[02:00:57.781] Build status: STARTED
[02:00:57.781] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:82:0) after 6m23s
[02:07:20.817] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:82:0)
[02:07:20.838] Build status: STARTED
[02:07:20.838] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:83:0) after 4m21s
[02:11:41.825] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:83:0)
[02:11:41.859] Build status: STARTED
[02:11:41.859] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:84:0) after 4m45s
[02:16:26.883] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:84:0)
[02:16:26.905] Build status: STARTED
[02:16:26.905] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:85:0) after 8m49s
[02:25:15.928] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:85:0)
[02:25:15.954] Build status: STARTED
[02:25:15.954] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:86:0) after 6m19s
[02:31:35.028] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:86:0)
[02:31:35.048] Build status: STARTED
[02:31:35.048] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:87:0) after 7m39s
[02:39:14.070] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:87:0)
[02:39:14.105] Build status: STARTED
[02:39:14.105] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:88:0) after 3m30s
[02:42:45.436] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:88:0)
[02:42:45.459] Build status: STARTED
[02:42:45.459] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:89:0) after 2m19s
[02:45:04.518] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:89:0)
[02:45:04.533] Build status: STARTED
[02:45:04.533] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:90:0) after 5m25s
[02:50:29.702] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:90:0)
[02:50:29.742] Build status: STARTED
[02:50:29.742] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:91:0) after 9m34s
[03:00:03.780] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:91:0)
[03:00:03.799] Build status: STARTED
[03:00:03.799] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:92:0) after 3m18s
[03:03:21.929] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:92:0)
[03:03:21.976] Build status: STARTED
[03:03:21.976] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:93:0) after 4m42s
[03:08:04.006] Handling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:93:0)
[03:08:04.058] Build status: STARTED
[03:08:04.058] Scheduling timer "check-buildbucket-build-status" (r8/win:8910289783613865440:94:0) after 6m32s
[03:09:56.455] Received PubSub notification, asking Buildbucket for the build status
[03:09:56.476] Build:
{
  "id": "8744859721742787569",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 42,
  "createdBy": "project:r8",
  "createTime": "2024-06-17T18:28:25.006356666Z",
  "startTime": "2024-06-17T20:46:22.726324338Z",
  "endTime": "2024-06-18T03:09:41.422883783Z",
  "updateTime": "2024-06-18T03:09:41.422883783Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "45140f080ca3520dc530eab514758b0339ebd1d2",
      "ref": "refs/heads/main"
    }
  }
}
[03:09:56.476] Invocation finished in 8h41m32.638162957s with status FAILED