Status: SUCCEEDED
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": "edfc8d0044b005a21d8d776faccb9d2de9614bac"
}

Incoming tags

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

Debug log (UTC)

[15:08:24.147] New invocation is queued and will start shortly
[15:08:25.255] Starting the invocation (attempt 1)
[15:08:25.282] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/edfc8d0044b005a21d8d776faccb9d2de9614bac"
[15:08:25.282] Popped gitiles commit info from properties and tags
[15:08:25.282] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:08:25.282] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:08:25.282] Buildbucket request:
{
  "requestId": "8879861785505152400",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8879861785505152400",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "27ba33236997fe39f20213c00d302fafaacce80c"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@27ba33236997fe39f20213c00d302fafaacce80c",
                        "title": "27ba33236997fe39f20213c00d302fafaacce80c",
                        "url": "https://r8.googlesource.com/r8/+/27ba33236997fe39f20213c00d302fafaacce80c"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "f7eee2f2b00b7aadbca369b1bc68c67076c5ce6d"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@f7eee2f2b00b7aadbca369b1bc68c67076c5ce6d",
                        "title": "f7eee2f2b00b7aadbca369b1bc68c67076c5ce6d",
                        "url": "https://r8.googlesource.com/r8/+/f7eee2f2b00b7aadbca369b1bc68c67076c5ce6d"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "bf5dac9bb1c21ebb668577cd35e25982d5978593"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@bf5dac9bb1c21ebb668577cd35e25982d5978593",
                        "title": "bf5dac9bb1c21ebb668577cd35e25982d5978593",
                        "url": "https://r8.googlesource.com/r8/+/bf5dac9bb1c21ebb668577cd35e25982d5978593"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "edfc8d0044b005a21d8d776faccb9d2de9614bac"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@edfc8d0044b005a21d8d776faccb9d2de9614bac",
                        "title": "edfc8d0044b005a21d8d776faccb9d2de9614bac",
                        "url": "https://r8.googlesource.com/r8/+/edfc8d0044b005a21d8d776faccb9d2de9614bac"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "edfc8d0044b005a21d8d776faccb9d2de9614bac",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8879861785505152400"
    },
    {
      "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:08:25.717] Scheduled build:
{
  "id": "8714431723569792241",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 774,
  "createdBy": "project:r8",
  "createTime": "2025-05-19T15:08:25.363224244Z",
  "updateTime": "2025-05-19T15:08:25.363224244Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "edfc8d0044b005a21d8d776faccb9d2de9614bac",
      "ref": "refs/heads/main"
    }
  }
}
[15:08:25.717] Task URL: https://cr-buildbucket.appspot.com/build/8714431723569792241
[15:08:25.717] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:2:0) after 1m45s
[15:08:26.732] Received PubSub notification, asking Buildbucket for the build status
[15:08:26.758] Build status: SCHEDULED
[15:10:10.711] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:2:0)
[15:10:10.742] Build status: SCHEDULED
[15:10:10.742] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:4:0) after 6m58s
[15:17:08.773] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:4:0)
[15:17:08.797] Build status: SCHEDULED
[15:17:08.797] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:5:0) after 4m23s
[15:21:31.819] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:5:0)
[15:21:31.846] Build status: SCHEDULED
[15:21:31.846] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:6:0) after 8m38s
[15:30:09.862] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:6:0)
[15:30:10.278] Build status: SCHEDULED
[15:30:10.278] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:7:0) after 1m45s
[15:31:55.343] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:7:0)
[15:31:55.431] Build status: SCHEDULED
[15:31:55.431] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:8:0) after 6m20s
[15:38:15.447] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:8:0)
[15:38:15.485] Build status: SCHEDULED
[15:38:15.485] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:9:0) after 4m6s
[15:42:21.549] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:9:0)
[15:42:21.579] Build status: SCHEDULED
[15:42:21.579] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:10:0) after 5m41s
[15:48:02.631] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:10:0)
[15:48:02.810] Build status: SCHEDULED
[15:48:02.810] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:11:0) after 8m58s
[15:57:00.843] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:11:0)
[15:57:00.869] Build status: SCHEDULED
[15:57:00.869] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:12:0) after 3m18s
[16:00:18.964] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:12:0)
[16:00:18.989] Build status: SCHEDULED
[16:00:18.989] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:13:0) after 9m32s
[16:09:51.046] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:13:0)
[16:09:51.078] Build status: SCHEDULED
[16:09:51.078] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:14:0) after 6m16s
[16:16:07.267] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:14:0)
[16:16:07.363] Build status: SCHEDULED
[16:16:07.363] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:15:0) after 9m5s
[16:25:12.387] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:15:0)
[16:25:12.404] Build status: SCHEDULED
[16:25:12.404] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:16:0) after 8m2s
[16:33:14.618] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:16:0)
[16:33:14.635] Build status: SCHEDULED
[16:33:14.635] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:17:0) after 9m29s
[16:42:43.704] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:17:0)
[16:42:43.813] Build status: SCHEDULED
[16:42:43.813] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:18:0) after 5m22s
[16:48:05.827] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:18:0)
[16:48:05.848] Build status: SCHEDULED
[16:48:05.848] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:19:0) after 8m5s
[16:56:10.863] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:19:0)
[16:56:10.917] Build status: SCHEDULED
[16:56:10.917] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:20:0) after 1m22s
[16:57:32.982] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:20:0)
[16:57:32.998] Build status: SCHEDULED
[16:57:32.998] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:21:0) after 1m40s
[16:59:13.043] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:21:0)
[16:59:13.066] Build status: SCHEDULED
[16:59:13.066] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:22:0) after 5m48s
[17:05:01.111] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:22:0)
[17:05:01.221] Build status: SCHEDULED
[17:05:01.221] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:23:0) after 7m24s
[17:12:25.240] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:23:0)
[17:12:25.262] Build status: SCHEDULED
[17:12:25.262] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:24:0) after 8m48s
[17:21:13.281] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:24:0)
[17:21:13.385] Build status: SCHEDULED
[17:21:13.385] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:25:0) after 8m1s
[17:29:14.401] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:25:0)
[17:29:14.479] Build status: SCHEDULED
[17:29:14.479] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:26:0) after 2m10s
[17:31:24.543] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:26:0)
[17:31:24.578] Build status: SCHEDULED
[17:31:24.578] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:27:0) after 7m18s
[17:38:42.606] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:27:0)
[17:38:42.626] Build status: SCHEDULED
[17:38:42.626] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:28:0) after 3m7s
[17:41:49.648] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:28:0)
[17:41:49.669] Build status: SCHEDULED
[17:41:49.669] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:29:0) after 2m19s
[17:44:08.693] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:29:0)
[17:44:08.726] Build status: SCHEDULED
[17:44:08.726] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:30:0) after 7m52s
[17:52:00.792] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:30:0)
[17:52:00.819] Build status: SCHEDULED
[17:52:00.819] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:31:0) after 3m41s
[17:55:41.856] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:31:0)
[17:55:41.876] Build status: SCHEDULED
[17:55:41.876] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:32:0) after 4m20s
[18:00:01.930] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:32:0)
[18:00:02.118] Build status: SCHEDULED
[18:00:02.118] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:33:0) after 3m32s
[18:03:34.287] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:33:0)
[18:03:34.308] Build status: SCHEDULED
[18:03:34.308] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:34:0) after 2m44s
[18:06:18.353] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:34:0)
[18:06:18.372] Build status: SCHEDULED
[18:06:18.372] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:35:0) after 5m37s
[18:11:55.449] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:35:0)
[18:11:55.471] Build status: SCHEDULED
[18:11:55.471] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:36:0) after 8m23s
[18:20:18.550] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:36:0)
[18:20:18.575] Build status: SCHEDULED
[18:20:18.576] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:37:0) after 8m41s
[18:23:58.980] Received PubSub notification, asking Buildbucket for the build status
[18:23:59.012] Build status: STARTED
[18:28:59.710] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:37:0)
[18:28:59.756] Build status: STARTED
[18:28:59.756] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:39:0) after 3m49s
[18:32:48.738] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:39:0)
[18:32:48.755] Build status: STARTED
[18:32:48.755] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:40:0) after 5m53s
[18:38:41.889] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:40:0)
[18:38:41.906] Build status: STARTED
[18:38:41.906] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:41:0) after 3m45s
[18:42:27.023] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:41:0)
[18:42:27.050] Build status: STARTED
[18:42:27.050] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:42:0) after 6m42s
[18:49:09.054] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:42:0)
[18:49:09.071] Build status: STARTED
[18:49:09.071] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:43:0) after 6m57s
[18:56:06.195] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:43:0)
[18:56:06.233] Build status: STARTED
[18:56:06.233] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:44:0) after 3m53s
[18:59:59.328] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:44:0)
[18:59:59.948] Build status: STARTED
[18:59:59.948] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:45:0) after 8m41s
[19:08:41.055] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:45:0)
[19:08:41.121] Build status: STARTED
[19:08:41.121] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:46:0) after 3m38s
[19:12:19.128] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:46:0)
[19:12:19.147] Build status: STARTED
[19:12:19.147] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:47:0) after 4m17s
[19:16:36.169] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:47:0)
[19:16:36.184] Build status: STARTED
[19:16:36.184] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:48:0) after 7m30s
[19:24:06.212] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:48:0)
[19:24:06.233] Build status: STARTED
[19:24:06.233] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:49:0) after 1m37s
[19:25:43.250] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:49:0)
[19:25:43.268] Build status: STARTED
[19:25:43.268] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:50:0) after 3m49s
[19:29:32.357] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:50:0)
[19:29:32.432] Build status: STARTED
[19:29:32.432] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:51:0) after 5m10s
[19:34:42.501] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:51:0)
[19:34:42.522] Build status: STARTED
[19:34:42.522] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:52:0) after 1m40s
[19:36:22.528] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:52:0)
[19:36:22.555] Build status: STARTED
[19:36:22.555] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:53:0) after 7m45s
[19:44:07.642] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:53:0)
[19:44:07.658] Build status: STARTED
[19:44:07.658] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:54:0) after 4m49s
[19:48:56.733] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:54:0)
[19:48:56.787] Build status: STARTED
[19:48:56.788] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:55:0) after 8m15s
[19:57:11.812] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:55:0)
[19:57:11.836] Build status: STARTED
[19:57:11.836] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:56:0) after 8m15s
[20:05:26.957] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:56:0)
[20:05:27.101] Build status: STARTED
[20:05:27.101] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:57:0) after 7m35s
[20:13:02.119] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:57:0)
[20:13:02.144] Build status: STARTED
[20:13:02.144] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:58:0) after 8m5s
[20:21:07.149] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:58:0)
[20:21:07.172] Build status: STARTED
[20:21:07.172] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:59:0) after 6m27s
[20:27:34.289] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:59:0)
[20:27:35.102] Build status: STARTED
[20:27:35.102] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:60:0) after 8m44s
[20:36:19.140] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:60:0)
[20:36:19.164] Build status: STARTED
[20:36:19.164] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:61:0) after 9m57s
[20:46:16.330] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:61:0)
[20:46:16.355] Build status: STARTED
[20:46:16.355] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:62:0) after 2m11s
[20:48:27.622] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:62:0)
[20:48:27.695] Build status: STARTED
[20:48:27.695] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:63:0) after 8m35s
[20:57:02.801] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:63:0)
[20:57:02.824] Build status: STARTED
[20:57:02.824] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:64:0) after 9m33s
[21:06:35.852] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:64:0)
[21:06:35.882] Build status: STARTED
[21:06:35.882] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:65:0) after 5m40s
[21:12:15.916] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:65:0)
[21:12:15.936] Build status: STARTED
[21:12:15.936] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:66:0) after 6m0s
[21:18:15.961] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:66:0)
[21:18:15.985] Build status: STARTED
[21:18:15.985] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:67:0) after 2m8s
[21:20:24.008] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:67:0)
[21:20:24.037] Build status: STARTED
[21:20:24.037] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:68:0) after 9m10s
[21:29:34.041] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:68:0)
[21:29:34.059] Build status: STARTED
[21:29:34.059] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:69:0) after 4m13s
[21:33:47.149] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:69:0)
[21:33:47.174] Build status: STARTED
[21:33:47.174] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:70:0) after 9m57s
[21:43:44.328] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:70:0)
[21:43:44.349] Build status: STARTED
[21:43:44.349] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:71:0) after 2m59s
[21:46:43.400] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:71:0)
[21:46:43.422] Build status: STARTED
[21:46:43.422] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:72:0) after 1m22s
[21:48:05.557] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:72:0)
[21:48:05.630] Build status: STARTED
[21:48:05.630] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:73:0) after 4m29s
[21:52:34.611] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:73:0)
[21:52:34.631] Build status: STARTED
[21:52:34.631] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:74:0) after 7m7s
[21:59:41.666] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:74:0)
[21:59:41.723] Build status: STARTED
[21:59:41.723] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:75:0) after 2m39s
[22:02:20.768] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:75:0)
[22:02:20.786] Build status: STARTED
[22:02:20.786] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:76:0) after 9m53s
[22:12:13.853] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:76:0)
[22:12:13.875] Build status: STARTED
[22:12:13.875] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:77:0) after 6m34s
[22:18:47.940] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:77:0)
[22:18:47.964] Build status: STARTED
[22:18:47.964] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:78:0) after 9m46s
[22:28:33.979] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:78:0)
[22:28:34.053] Build status: STARTED
[22:28:34.053] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:79:0) after 3m58s
[22:32:32.077] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:79:0)
[22:32:32.147] Build status: STARTED
[22:32:32.147] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:80:0) after 2m53s
[22:35:25.360] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:80:0)
[22:35:25.427] Build status: STARTED
[22:35:25.427] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:81:0) after 5m15s
[22:40:40.481] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:81:0)
[22:40:40.506] Build status: STARTED
[22:40:40.506] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:82:0) after 5m31s
[22:46:11.533] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:82:0)
[22:46:11.570] Build status: STARTED
[22:46:11.570] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:83:0) after 8m7s
[22:54:18.590] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:83:0)
[22:54:18.617] Build status: STARTED
[22:54:18.617] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:84:0) after 6m49s
[23:01:07.652] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:84:0)
[23:01:07.679] Build status: STARTED
[23:01:07.679] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:85:0) after 3m42s
[23:04:49.700] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:85:0)
[23:04:49.725] Build status: STARTED
[23:04:49.725] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:86:0) after 9m22s
[23:14:11.753] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:86:0)
[23:14:11.780] Build status: STARTED
[23:14:11.780] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:87:0) after 1m27s
[23:15:38.830] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:87:0)
[23:15:38.857] Build status: STARTED
[23:15:38.857] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:88:0) after 5m16s
[23:20:54.899] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:88:0)
[23:20:54.916] Build status: STARTED
[23:20:54.916] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:89:0) after 5m26s
[23:26:20.938] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:89:0)
[23:26:20.965] Build status: STARTED
[23:26:20.965] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:90:0) after 2m27s
[23:28:48.058] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:90:0)
[23:28:48.156] Build status: STARTED
[23:28:48.156] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:91:0) after 4m27s
[23:33:15.213] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:91:0)
[23:33:15.231] Build status: STARTED
[23:33:15.231] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:92:0) after 9m25s
[23:42:40.256] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:92:0)
[23:42:40.285] Build status: STARTED
[23:42:40.285] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:93:0) after 3m47s
[23:46:27.360] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:93:0)
[23:46:27.850] Build status: STARTED
[23:46:27.850] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:94:0) after 7m40s
[23:54:07.947] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:94:0)
[23:54:07.979] Build status: STARTED
[23:54:07.979] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:95:0) after 4m45s
[23:58:53.145] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:95:0)
[23:58:53.178] Build status: STARTED
[23:58:53.178] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:96:0) after 6m55s
[00:05:48.251] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:96:0)
[00:05:48.268] Build status: STARTED
[00:05:48.268] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:97:0) after 8m42s
[00:14:30.333] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:97:0)
[00:14:30.420] Build status: STARTED
[00:14:30.420] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:98:0) after 4m14s
[00:18:44.442] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:98:0)
[00:18:44.464] Build status: STARTED
[00:18:44.464] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:99:0) after 9m56s
[00:28:40.547] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:99:0)
[00:28:40.588] Build status: STARTED
[00:28:40.588] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:100:0) after 3m45s
[00:32:25.617] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:100:0)
[00:32:25.645] Build status: STARTED
[00:32:25.645] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:101:0) after 4m30s
[00:36:55.694] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:101:0)
[00:36:55.710] Build status: STARTED
[00:36:55.710] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:102:0) after 3m14s
[00:40:09.895] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:102:0)
[00:40:09.952] Build status: STARTED
[00:40:09.952] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:103:0) after 3m42s
[00:43:52.036] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:103:0)
[00:43:52.060] Build status: STARTED
[00:43:52.060] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:104:0) after 1m52s
[00:45:44.077] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:104:0)
[00:45:44.095] Build status: STARTED
[00:45:44.095] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:105:0) after 6m56s
[00:52:40.120] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:105:0)
[00:52:40.148] Build status: STARTED
[00:52:40.148] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:106:0) after 9m37s
[01:02:17.142] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:106:0)
[01:02:17.320] Build status: STARTED
[01:02:17.320] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:107:0) after 8m35s
[01:10:52.339] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:107:0)
[01:10:52.355] Build status: STARTED
[01:10:52.355] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:108:0) after 3m17s
[01:14:09.382] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:108:0)
[01:14:09.466] Build status: STARTED
[01:14:09.466] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:109:0) after 6m26s
[01:20:35.517] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:109:0)
[01:20:35.535] Build status: STARTED
[01:20:35.536] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:110:0) after 1m11s
[01:21:46.606] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:110:0)
[01:21:46.635] Build status: STARTED
[01:21:46.635] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:111:0) after 2m53s
[01:24:39.657] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:111:0)
[01:24:39.688] Build status: STARTED
[01:24:39.688] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:112:0) after 7m55s
[01:32:34.720] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:112:0)
[01:32:34.739] Build status: STARTED
[01:32:34.739] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:113:0) after 5m0s
[01:37:34.780] Handling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:113:0)
[01:37:34.798] Build status: STARTED
[01:37:34.798] Scheduling timer "check-buildbucket-build-status" (r8/win:8879861785505152400:114:0) after 5m46s
[01:40:59.665] Received PubSub notification, asking Buildbucket for the build status
[01:40:59.703] Build:
{
  "id": "8714431723569792241",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 774,
  "createdBy": "project:r8",
  "createTime": "2025-05-19T15:08:25.363224244Z",
  "startTime": "2025-05-19T18:23:58.760722558Z",
  "endTime": "2025-05-20T01:40:51.024135436Z",
  "updateTime": "2025-05-20T01:40:51.024135436Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "edfc8d0044b005a21d8d776faccb9d2de9614bac",
      "ref": "refs/heads/main"
    }
  }
}
[01:40:59.703] Invocation finished in 10h32m35.568154784s with status SUCCEEDED