Status: FAILED
Triggered by: -
Duration: 10 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": "cf0a132933b42d260414574caff67bf21d1a4c83"
}

Incoming tags

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

Debug log (UTC)

[15:19:40.189] New invocation is queued and will start shortly
[15:19:41.553] Starting the invocation (attempt 1)
[15:19:41.585] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/cf0a132933b42d260414574caff67bf21d1a4c83"
[15:19:41.585] Popped gitiles commit info from properties and tags
[15:19:41.585] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:19:41.585] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:19:41.585] Buildbucket request:
{
  "requestId": "8887380624829595664",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8887380624829595664",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "9f2646f63873ff885f599bc7fef9475ebbae1e04"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@9f2646f63873ff885f599bc7fef9475ebbae1e04",
                        "title": "9f2646f63873ff885f599bc7fef9475ebbae1e04",
                        "url": "https://r8.googlesource.com/r8/+/9f2646f63873ff885f599bc7fef9475ebbae1e04"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "cf0a132933b42d260414574caff67bf21d1a4c83"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@cf0a132933b42d260414574caff67bf21d1a4c83",
                        "title": "cf0a132933b42d260414574caff67bf21d1a4c83",
                        "url": "https://r8.googlesource.com/r8/+/cf0a132933b42d260414574caff67bf21d1a4c83"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "cf0a132933b42d260414574caff67bf21d1a4c83",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8887380624829595664"
    },
    {
      "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"
  }
}
[15:19:42.037] Scheduled build:
{
  "id": "8721950562612178673",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 592,
  "createdBy": "project:r8",
  "createTime": "2025-02-25T15:19:41.679242145Z",
  "updateTime": "2025-02-25T15:19:41.679242145Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "cf0a132933b42d260414574caff67bf21d1a4c83",
      "ref": "refs/heads/main"
    }
  }
}
[15:19:42.037] Task URL: https://cr-buildbucket.appspot.com/build/8721950562612178673
[15:19:42.037] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:2:0) after 3m36s
[15:19:42.111] Received PubSub notification, asking Buildbucket for the build status
[15:19:42.138] Build status: SCHEDULED
[15:23:18.052] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:2:0)
[15:23:18.077] Build status: SCHEDULED
[15:23:18.077] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:4:0) after 6m38s
[15:29:56.108] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:4:0)
[15:29:56.133] Build status: SCHEDULED
[15:29:56.133] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:5:0) after 8m49s
[15:38:45.147] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:5:0)
[15:38:45.175] Build status: SCHEDULED
[15:38:45.175] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:6:0) after 4m11s
[15:42:56.196] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:6:0)
[15:42:56.335] Build status: SCHEDULED
[15:42:56.335] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:7:0) after 9m42s
[15:52:38.410] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:7:0)
[15:52:38.435] Build status: SCHEDULED
[15:52:38.435] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:8:0) after 5m30s
[15:58:08.466] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:8:0)
[15:58:08.489] Build status: SCHEDULED
[15:58:08.489] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:9:0) after 6m39s
[16:04:47.505] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:9:0)
[16:04:47.532] Build status: SCHEDULED
[16:04:47.532] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:10:0) after 7m47s
[16:12:34.554] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:10:0)
[16:12:34.578] Build status: SCHEDULED
[16:12:34.578] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:11:0) after 9m7s
[16:21:41.595] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:11:0)
[16:21:41.630] Build status: SCHEDULED
[16:21:41.630] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:12:0) after 3m44s
[16:25:25.652] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:12:0)
[16:25:25.677] Build status: SCHEDULED
[16:25:25.677] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:13:0) after 1m51s
[16:27:16.707] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:13:0)
[16:27:16.734] Build status: SCHEDULED
[16:27:16.734] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:14:0) after 3m45s
[16:31:01.863] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:14:0)
[16:31:02.103] Build status: SCHEDULED
[16:31:02.103] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:15:0) after 8m42s
[16:39:44.129] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:15:0)
[16:39:44.159] Build status: SCHEDULED
[16:39:44.159] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:16:0) after 5m4s
[16:44:48.222] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:16:0)
[16:44:48.244] Build status: SCHEDULED
[16:44:48.244] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:17:0) after 9m19s
[16:54:07.360] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:17:0)
[16:54:07.375] Build status: SCHEDULED
[16:54:07.375] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:18:0) after 7m56s
[17:02:03.395] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:18:0)
[17:02:03.422] Build status: SCHEDULED
[17:02:03.422] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:19:0) after 8m43s
[17:10:46.440] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:19:0)
[17:10:46.482] Build status: SCHEDULED
[17:10:46.482] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:20:0) after 4m53s
[17:15:39.498] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:20:0)
[17:15:39.511] Build status: SCHEDULED
[17:15:39.511] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:21:0) after 2m29s
[17:18:08.525] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:21:0)
[17:18:08.542] Build status: SCHEDULED
[17:18:08.542] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:22:0) after 4m29s
[17:22:37.564] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:22:0)
[17:22:37.581] Build status: SCHEDULED
[17:22:37.581] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:23:0) after 3m37s
[17:26:14.601] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:23:0)
[17:26:14.632] Build status: SCHEDULED
[17:26:14.632] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:24:0) after 1m32s
[17:27:46.619] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:24:0)
[17:27:46.653] Build status: SCHEDULED
[17:27:46.653] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:25:0) after 7m32s
[17:35:18.659] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:25:0)
[17:35:18.685] Build status: SCHEDULED
[17:35:18.685] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:26:0) after 4m30s
[17:39:48.756] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:26:0)
[17:39:48.776] Build status: SCHEDULED
[17:39:48.776] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:27:0) after 8m56s
[17:43:56.886] Received PubSub notification, asking Buildbucket for the build status
[17:43:56.915] Build status: STARTED
[17:48:44.930] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:27:0)
[17:48:44.961] Build status: STARTED
[17:48:44.961] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:29:0) after 5m33s
[17:54:17.983] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:29:0)
[17:54:18.013] Build status: STARTED
[17:54:18.014] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:30:0) after 1m43s
[17:56:01.057] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:30:0)
[17:56:01.100] Build status: STARTED
[17:56:01.100] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:31:0) after 2m57s
[17:58:58.169] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:31:0)
[17:58:58.186] Build status: STARTED
[17:58:58.186] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:32:0) after 3m36s
[18:02:34.208] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:32:0)
[18:02:34.234] Build status: STARTED
[18:02:34.234] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:33:0) after 4m52s
[18:07:26.200] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:33:0)
[18:07:26.234] Build status: STARTED
[18:07:26.234] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:34:0) after 6m56s
[18:14:22.309] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:34:0)
[18:14:22.336] Build status: STARTED
[18:14:22.336] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:35:0) after 9m33s
[18:23:55.359] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:35:0)
[18:23:55.374] Build status: STARTED
[18:23:55.374] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:36:0) after 2m28s
[18:26:23.431] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:36:0)
[18:26:23.460] Build status: STARTED
[18:26:23.460] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:37:0) after 2m8s
[18:28:31.573] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:37:0)
[18:28:31.658] Build status: STARTED
[18:28:31.658] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:38:0) after 3m49s
[18:32:20.682] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:38:0)
[18:32:20.707] Build status: STARTED
[18:32:20.707] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:39:0) after 7m31s
[18:39:51.731] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:39:0)
[18:39:51.758] Build status: STARTED
[18:39:51.758] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:40:0) after 6m24s
[18:46:15.775] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:40:0)
[18:46:15.970] Build status: STARTED
[18:46:15.970] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:41:0) after 8m3s
[18:54:18.988] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:41:0)
[18:54:19.005] Build status: STARTED
[18:54:19.005] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:42:0) after 2m36s
[18:56:54.983] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:42:0)
[18:56:55.011] Build status: STARTED
[18:56:55.011] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:43:0) after 2m45s
[18:59:39.991] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:43:0)
[18:59:40.028] Build status: STARTED
[18:59:40.028] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:44:0) after 3m20s
[19:03:00.104] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:44:0)
[19:03:00.128] Build status: STARTED
[19:03:00.129] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:45:0) after 6m30s
[19:09:30.154] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:45:0)
[19:09:30.218] Build status: STARTED
[19:09:30.218] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:46:0) after 2m38s
[19:12:08.367] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:46:0)
[19:12:08.385] Build status: STARTED
[19:12:08.385] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:47:0) after 1m10s
[19:13:18.404] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:47:0)
[19:13:18.425] Build status: STARTED
[19:13:18.425] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:48:0) after 1m3s
[19:14:21.410] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:48:0)
[19:14:21.427] Build status: STARTED
[19:14:21.427] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:49:0) after 1m48s
[19:16:09.492] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:49:0)
[19:16:09.507] Build status: STARTED
[19:16:09.507] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:50:0) after 3m56s
[19:20:05.530] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:50:0)
[19:20:05.547] Build status: STARTED
[19:20:05.547] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:51:0) after 4m23s
[19:24:28.538] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:51:0)
[19:24:28.599] Build status: STARTED
[19:24:28.599] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:52:0) after 2m37s
[19:27:05.765] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:52:0)
[19:27:05.783] Build status: STARTED
[19:27:05.783] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:53:0) after 2m17s
[19:29:22.807] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:53:0)
[19:29:22.845] Build status: STARTED
[19:29:22.845] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:54:0) after 5m43s
[19:35:06.015] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:54:0)
[19:35:06.040] Build status: STARTED
[19:35:06.040] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:55:0) after 9m34s
[19:44:40.062] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:55:0)
[19:44:40.082] Build status: STARTED
[19:44:40.082] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:56:0) after 3m23s
[19:48:03.150] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:56:0)
[19:48:03.175] Build status: STARTED
[19:48:03.175] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:57:0) after 2m44s
[19:50:47.212] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:57:0)
[19:50:47.249] Build status: STARTED
[19:50:47.249] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:58:0) after 5m36s
[19:56:23.276] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:58:0)
[19:56:23.289] Build status: STARTED
[19:56:23.289] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:59:0) after 5m31s
[20:01:54.326] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:59:0)
[20:01:54.395] Build status: STARTED
[20:01:54.395] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:60:0) after 5m59s
[20:07:53.556] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:60:0)
[20:07:53.734] Build status: STARTED
[20:07:53.734] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:61:0) after 8m13s
[20:16:06.897] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:61:0)
[20:16:06.916] Build status: STARTED
[20:16:06.916] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:62:0) after 3m1s
[20:19:08.059] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:62:0)
[20:19:08.077] Build status: STARTED
[20:19:08.077] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:63:0) after 3m16s
[20:22:24.203] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:63:0)
[20:22:24.242] Build status: STARTED
[20:22:24.242] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:64:0) after 4m34s
[20:26:58.251] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:64:0)
[20:26:58.326] Build status: STARTED
[20:26:58.326] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:65:0) after 8m59s
[20:35:57.406] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:65:0)
[20:35:57.434] Build status: STARTED
[20:35:57.434] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:66:0) after 1m53s
[20:37:50.459] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:66:0)
[20:37:50.482] Build status: STARTED
[20:37:50.482] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:67:0) after 7m54s
[20:45:44.470] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:67:0)
[20:45:44.510] Build status: STARTED
[20:45:44.510] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:68:0) after 8m46s
[20:54:30.557] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:68:0)
[20:54:30.574] Build status: STARTED
[20:54:30.574] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:69:0) after 7m5s
[21:01:35.603] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:69:0)
[21:01:35.618] Build status: STARTED
[21:01:35.618] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:70:0) after 8m10s
[21:09:45.678] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:70:0)
[21:09:45.705] Build status: STARTED
[21:09:45.705] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:71:0) after 1m17s
[21:11:02.851] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:71:0)
[21:11:02.880] Build status: STARTED
[21:11:02.880] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:72:0) after 1m12s
[21:12:14.873] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:72:0)
[21:12:14.889] Build status: STARTED
[21:12:14.889] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:73:0) after 4m40s
[21:16:54.974] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:73:0)
[21:16:55.001] Build status: STARTED
[21:16:55.001] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:74:0) after 6m1s
[21:22:56.022] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:74:0)
[21:22:56.045] Build status: STARTED
[21:22:56.045] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:75:0) after 2m40s
[21:25:36.061] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:75:0)
[21:25:36.085] Build status: STARTED
[21:25:36.085] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:76:0) after 2m50s
[21:28:26.204] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:76:0)
[21:28:26.246] Build status: STARTED
[21:28:26.246] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:77:0) after 7m51s
[21:36:17.271] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:77:0)
[21:36:17.286] Build status: STARTED
[21:36:17.286] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:78:0) after 5m25s
[21:41:42.525] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:78:0)
[21:41:42.541] Build status: STARTED
[21:41:42.541] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:79:0) after 5m58s
[21:47:40.562] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:79:0)
[21:47:40.588] Build status: STARTED
[21:47:40.588] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:80:0) after 8m20s
[21:56:00.612] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:80:0)
[21:56:00.649] Build status: STARTED
[21:56:00.649] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:81:0) after 3m52s
[21:59:52.710] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:81:0)
[21:59:52.735] Build status: STARTED
[21:59:52.735] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:82:0) after 8m36s
[22:08:28.955] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:82:0)
[22:08:28.984] Build status: STARTED
[22:08:28.984] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:83:0) after 5m47s
[22:14:16.030] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:83:0)
[22:14:16.071] Build status: STARTED
[22:14:16.071] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:84:0) after 1m52s
[22:16:08.121] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:84:0)
[22:16:08.137] Build status: STARTED
[22:16:08.137] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:85:0) after 1m52s
[22:18:00.275] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:85:0)
[22:18:00.299] Build status: STARTED
[22:18:00.299] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:86:0) after 4m40s
[22:22:40.320] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:86:0)
[22:22:40.333] Build status: STARTED
[22:22:40.333] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:87:0) after 7m3s
[22:29:43.349] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:87:0)
[22:29:43.386] Build status: STARTED
[22:29:43.386] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:88:0) after 5m21s
[22:35:04.486] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:88:0)
[22:35:04.515] Build status: STARTED
[22:35:04.515] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:89:0) after 9m38s
[22:44:42.501] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:89:0)
[22:44:42.529] Build status: STARTED
[22:44:42.529] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:90:0) after 4m40s
[22:49:22.531] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:90:0)
[22:49:22.558] Build status: STARTED
[22:49:22.559] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:91:0) after 7m44s
[22:57:06.659] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:91:0)
[22:57:06.688] Build status: STARTED
[22:57:06.688] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:92:0) after 7m34s
[23:04:40.780] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:92:0)
[23:04:40.804] Build status: STARTED
[23:04:40.804] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:93:0) after 5m2s
[23:09:42.892] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:93:0)
[23:09:42.929] Build status: STARTED
[23:09:42.929] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:94:0) after 4m44s
[23:14:26.948] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:94:0)
[23:14:26.976] Build status: STARTED
[23:14:26.976] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:95:0) after 3m25s
[23:17:51.999] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:95:0)
[23:17:52.026] Build status: STARTED
[23:17:52.026] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:96:0) after 3m1s
[23:20:53.044] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:96:0)
[23:20:53.122] Build status: STARTED
[23:20:53.122] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:97:0) after 9m26s
[23:30:19.199] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:97:0)
[23:30:19.281] Build status: STARTED
[23:30:19.281] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:98:0) after 3m40s
[23:33:59.266] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:98:0)
[23:33:59.307] Build status: STARTED
[23:33:59.307] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:99:0) after 5m50s
[23:39:49.397] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:99:0)
[23:39:49.415] Build status: STARTED
[23:39:49.415] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:100:0) after 8m28s
[23:48:17.457] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:100:0)
[23:48:17.481] Build status: STARTED
[23:48:17.481] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:101:0) after 3m8s
[23:51:25.748] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:101:0)
[23:51:25.770] Build status: STARTED
[23:51:25.770] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:102:0) after 6m11s
[23:57:36.780] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:102:0)
[23:57:36.847] Build status: STARTED
[23:57:36.847] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:103:0) after 2m58s
[00:00:34.927] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:103:0)
[00:00:34.949] Build status: STARTED
[00:00:34.949] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:104:0) after 5m19s
[00:05:54.066] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:104:0)
[00:05:54.129] Build status: STARTED
[00:05:54.129] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:105:0) after 4m30s
[00:10:24.158] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:105:0)
[00:10:24.175] Build status: STARTED
[00:10:24.175] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:106:0) after 3m38s
[00:14:02.235] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:106:0)
[00:14:02.319] Build status: STARTED
[00:14:02.319] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:107:0) after 5m4s
[00:19:06.323] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:107:0)
[00:19:06.379] Build status: STARTED
[00:19:06.379] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:108:0) after 6m13s
[00:25:19.418] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:108:0)
[00:25:19.439] Build status: STARTED
[00:25:19.439] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:109:0) after 6m40s
[00:31:59.506] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:109:0)
[00:31:59.531] Build status: STARTED
[00:31:59.532] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:110:0) after 6m23s
[00:38:22.649] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:110:0)
[00:38:22.671] Build status: STARTED
[00:38:22.671] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:111:0) after 6m50s
[00:45:12.700] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:111:0)
[00:45:12.724] Build status: STARTED
[00:45:12.724] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:112:0) after 3m15s
[00:48:27.741] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:112:0)
[00:48:27.771] Build status: STARTED
[00:48:27.771] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:113:0) after 1m40s
[00:50:07.796] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:113:0)
[00:50:07.815] Build status: STARTED
[00:50:07.815] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:114:0) after 9m22s
[00:59:29.927] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:114:0)
[00:59:29.963] Build status: STARTED
[00:59:29.963] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:115:0) after 9m28s
[01:08:57.945] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:115:0)
[01:08:57.969] Build status: STARTED
[01:08:57.969] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:116:0) after 7m16s
[01:16:13.988] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:116:0)
[01:16:14.009] Build status: STARTED
[01:16:14.009] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:117:0) after 1m0s
[01:17:14.046] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:117:0)
[01:17:14.074] Build status: STARTED
[01:17:14.074] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:118:0) after 1m10s
[01:18:24.079] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:118:0)
[01:18:24.152] Build status: STARTED
[01:18:24.152] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:119:0) after 4m47s
[01:23:11.220] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:119:0)
[01:23:11.245] Build status: STARTED
[01:23:11.245] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:120:0) after 9m8s
[01:32:19.299] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:120:0)
[01:32:19.344] Build status: STARTED
[01:32:19.345] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:121:0) after 4m39s
[01:36:58.370] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:121:0)
[01:36:58.397] Build status: STARTED
[01:36:58.397] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:122:0) after 4m9s
[01:41:07.523] Handling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:122:0)
[01:41:07.557] Build status: STARTED
[01:41:07.557] Scheduling timer "check-buildbucket-build-status" (r8/win:8887380624829595664:123:0) after 4m10s
[01:45:13.269] Received PubSub notification, asking Buildbucket for the build status
[01:45:13.285] Build:
{
  "id": "8721950562612178673",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 592,
  "createdBy": "project:r8",
  "createTime": "2025-02-25T15:19:41.679242145Z",
  "startTime": "2025-02-25T17:43:56.376259301Z",
  "endTime": "2025-02-26T01:45:12.929223820Z",
  "updateTime": "2025-02-26T01:45:12.929223820Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "cf0a132933b42d260414574caff67bf21d1a4c83",
      "ref": "refs/heads/main"
    }
  }
}
[01:45:13.285] Invocation finished in 10h25m33.104017494s with status FAILED