LUCI Scheduler :: r8 :: perf :: 8847600280178564816

Status: SUCCEEDED

Triggered by: -

Duration: 9 hours

Actions:

Definition (rev c50208f5f1a1a5046149c608c11b6df22a8d85ac)

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

Incoming triggers

5405d226baba0b87ea6a3f793ba7146ebf2ed1c6 (1 month ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[17:31:13.177] New invocation is queued and will start shortly
[17:31:14.232] Starting the invocation (attempt 1)
[17:31:14.258] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/5405d226baba0b87ea6a3f793ba7146ebf2ed1c6"
[17:31:14.258] Popped gitiles commit info from properties and tags
[17:31:14.258] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:31:14.258] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:31:14.258] Buildbucket request:
{
  "requestId": "8847600280178564816",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "perf"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8847600280178564816",
            "job": "r8/perf",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "5405d226baba0b87ea6a3f793ba7146ebf2ed1c6"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@5405d226baba0b87ea6a3f793ba7146ebf2ed1c6",
                        "title": "5405d226baba0b87ea6a3f793ba7146ebf2ed1c6",
                        "url": "https://r8.googlesource.com/r8/+/5405d226baba0b87ea6a3f793ba7146ebf2ed1c6"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "5405d226baba0b87ea6a3f793ba7146ebf2ed1c6",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8847600280178564816"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/perf"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[17:31:14.953] Scheduled build:
{
  "id": "8682170218324709697",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "perf"
  },
  "number": 2901,
  "createdBy": "project:r8",
  "createTime": "2026-05-10T17:31:14.324452666Z",
  "updateTime": "2026-05-10T17:31:14.324452666Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "5405d226baba0b87ea6a3f793ba7146ebf2ed1c6",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[17:31:14.953] Task URL: https://cr-buildbucket.appspot.com/build/8682170218324709697
[17:31:14.953] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:2:0) after 3m16s
[17:31:15.927] Received PubSub notification, asking Buildbucket for the build status
[17:31:15.984] Build status: SCHEDULED
[17:34:30.963] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:2:0)
[17:34:30.981] Build status: SCHEDULED
[17:34:30.981] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:4:0) after 6m36s
[17:41:07.023] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:4:0)
[17:41:07.054] Build status: SCHEDULED
[17:41:07.054] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:5:0) after 7m5s
[17:48:12.027] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:5:0)
[17:48:12.047] Build status: SCHEDULED
[17:48:12.047] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:6:0) after 4m10s
[17:52:22.072] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:6:0)
[17:52:22.091] Build status: SCHEDULED
[17:52:22.091] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:7:0) after 4m12s
[17:56:34.140] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:7:0)
[17:56:34.156] Build status: SCHEDULED
[17:56:34.156] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:8:0) after 9m9s
[18:05:43.940] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:8:0)
[18:05:43.956] Build status: SCHEDULED
[18:05:43.956] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:9:0) after 1m43s
[18:07:27.090] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:9:0)
[18:07:27.132] Build status: SCHEDULED
[18:07:27.132] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:10:0) after 5m15s
[18:12:42.581] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:10:0)
[18:12:42.607] Build status: SCHEDULED
[18:12:42.607] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:11:0) after 8m28s
[18:21:10.724] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:11:0)
[18:21:10.748] Build status: SCHEDULED
[18:21:10.748] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:12:0) after 6m55s
[18:28:05.775] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:12:0)
[18:28:05.823] Build status: SCHEDULED
[18:28:05.823] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:13:0) after 6m26s
[18:34:31.837] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:13:0)
[18:34:31.859] Build status: SCHEDULED
[18:34:31.859] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:14:0) after 5m34s
[18:40:06.065] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:14:0)
[18:40:06.082] Build status: SCHEDULED
[18:40:06.082] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:15:0) after 7m13s
[18:47:19.094] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:15:0)
[18:47:19.112] Build status: SCHEDULED
[18:47:19.112] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:16:0) after 6m42s
[18:54:01.245] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:16:0)
[18:54:01.261] Build status: SCHEDULED
[18:54:01.261] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:17:0) after 6m54s
[19:00:55.371] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:17:0)
[19:00:55.411] Build status: SCHEDULED
[19:00:55.411] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:18:0) after 1m2s
[19:01:57.423] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:18:0)
[19:01:57.456] Build status: SCHEDULED
[19:01:57.456] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:19:0) after 8m36s
[19:10:33.468] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:19:0)
[19:10:33.537] Build status: SCHEDULED
[19:10:33.537] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:20:0) after 8m21s
[19:18:54.580] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:20:0)
[19:18:54.741] Build status: SCHEDULED
[19:18:54.741] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:21:0) after 7m44s
[19:26:38.764] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:21:0)
[19:26:38.853] Build status: SCHEDULED
[19:26:38.853] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:22:0) after 1m11s
[19:27:49.982] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:22:0)
[19:27:50.010] Build status: SCHEDULED
[19:27:50.010] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:23:0) after 4m16s
[19:32:06.089] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:23:0)
[19:32:06.142] Build status: SCHEDULED
[19:32:06.142] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:24:0) after 8m10s
[19:40:16.821] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:24:0)
[19:40:17.008] Build status: SCHEDULED
[19:40:17.008] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:25:0) after 7m46s
[19:48:03.048] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:25:0)
[19:48:03.066] Build status: SCHEDULED
[19:48:03.066] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:26:0) after 2m53s
[19:50:56.128] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:26:0)
[19:50:56.142] Build status: SCHEDULED
[19:50:56.142] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:27:0) after 2m10s
[19:53:06.385] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:27:0)
[19:53:06.457] Build status: SCHEDULED
[19:53:06.457] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:28:0) after 8m56s
[20:02:02.501] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:28:0)
[20:02:02.523] Build status: SCHEDULED
[20:02:02.523] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:29:0) after 7m5s
[20:09:07.632] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:29:0)
[20:09:07.652] Build status: SCHEDULED
[20:09:07.652] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:30:0) after 8m41s
[20:17:49.110] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:30:0)
[20:17:49.131] Build status: SCHEDULED
[20:17:49.131] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:31:0) after 7m7s
[20:24:56.238] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:31:0)
[20:24:56.259] Build status: SCHEDULED
[20:24:56.259] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:32:0) after 2m15s
[20:27:11.337] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:32:0)
[20:27:11.356] Build status: SCHEDULED
[20:27:11.356] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:33:0) after 7m33s
[20:34:44.348] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:33:0)
[20:34:44.368] Build status: SCHEDULED
[20:34:44.368] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:34:0) after 2m10s
[20:36:54.391] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:34:0)
[20:36:54.409] Build status: SCHEDULED
[20:36:54.409] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:35:0) after 5m18s
[20:42:12.419] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:35:0)
[20:42:12.434] Build status: SCHEDULED
[20:42:12.434] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:36:0) after 4m57s
[20:47:09.449] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:36:0)
[20:47:09.495] Build status: SCHEDULED
[20:47:09.495] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:37:0) after 1m14s
[20:48:23.509] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:37:0)
[20:48:23.527] Build status: SCHEDULED
[20:48:23.527] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:38:0) after 2m58s
[20:51:21.778] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:38:0)
[20:51:21.803] Build status: SCHEDULED
[20:51:21.803] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:39:0) after 7m4s
[20:58:26.198] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:39:0)
[20:58:26.294] Build status: SCHEDULED
[20:58:26.294] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:40:0) after 8m6s
[21:06:32.417] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:40:0)
[21:06:32.435] Build status: SCHEDULED
[21:06:32.435] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:41:0) after 2m19s
[21:08:51.446] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:41:0)
[21:08:51.518] Build status: SCHEDULED
[21:08:51.518] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:42:0) after 8m50s
[21:17:41.613] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:42:0)
[21:17:41.650] Build status: SCHEDULED
[21:17:41.650] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:43:0) after 4m35s
[21:22:17.064] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:43:0)
[21:22:17.084] Build status: SCHEDULED
[21:22:17.084] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:44:0) after 7m38s
[21:29:55.459] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:44:0)
[21:29:55.514] Build status: SCHEDULED
[21:29:55.514] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:45:0) after 1m56s
[21:31:51.769] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:45:0)
[21:31:51.822] Build status: SCHEDULED
[21:31:51.822] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:46:0) after 5m36s
[21:37:27.916] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:46:0)
[21:37:27.940] Build status: SCHEDULED
[21:37:27.940] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:47:0) after 6m43s
[21:44:11.290] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:47:0)
[21:44:11.353] Build status: SCHEDULED
[21:44:11.353] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:48:0) after 6m36s
[21:50:47.367] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:48:0)
[21:50:47.380] Build status: SCHEDULED
[21:50:47.380] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:49:0) after 3m1s
[21:53:48.398] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:49:0)
[21:53:48.414] Build status: SCHEDULED
[21:53:48.414] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:50:0) after 7m9s
[22:00:57.426] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:50:0)
[22:00:57.448] Build status: SCHEDULED
[22:00:57.448] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:51:0) after 2m52s
[22:03:49.520] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:51:0)
[22:03:49.538] Build status: SCHEDULED
[22:03:49.538] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:52:0) after 9m56s
[22:13:45.948] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:52:0)
[22:13:45.963] Build status: SCHEDULED
[22:13:45.963] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:53:0) after 8m30s
[22:22:15.995] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:53:0)
[22:22:16.012] Build status: SCHEDULED
[22:22:16.012] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:54:0) after 2m30s
[22:24:46.034] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:54:0)
[22:24:46.057] Build status: SCHEDULED
[22:24:46.057] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:55:0) after 5m39s
[22:30:25.131] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:55:0)
[22:30:25.155] Build status: SCHEDULED
[22:30:25.155] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:56:0) after 6m10s
[22:36:35.166] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:56:0)
[22:36:35.185] Build status: SCHEDULED
[22:36:35.185] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:57:0) after 1m1s
[22:37:36.230] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:57:0)
[22:37:36.253] Build status: SCHEDULED
[22:37:36.253] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:58:0) after 3m53s
[22:41:29.468] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:58:0)
[22:41:29.543] Build status: SCHEDULED
[22:41:29.543] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:59:0) after 9m46s
[22:51:16.015] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:59:0)
[22:51:16.042] Build status: SCHEDULED
[22:51:16.042] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:60:0) after 9m16s
[23:00:32.057] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:60:0)
[23:00:32.080] Build status: SCHEDULED
[23:00:32.080] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:61:0) after 4m49s
[23:05:21.097] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:61:0)
[23:05:21.116] Build status: SCHEDULED
[23:05:21.116] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:62:0) after 3m25s
[23:08:46.134] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:62:0)
[23:08:46.151] Build status: SCHEDULED
[23:08:46.152] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:63:0) after 3m6s
[23:11:52.166] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:63:0)
[23:11:52.187] Build status: SCHEDULED
[23:11:52.187] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:64:0) after 7m56s
[23:19:48.202] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:64:0)
[23:19:48.220] Build status: SCHEDULED
[23:19:48.220] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:65:0) after 1m32s
[23:21:20.234] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:65:0)
[23:21:20.269] Build status: SCHEDULED
[23:21:20.270] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:66:0) after 8m29s
[23:29:49.287] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:66:0)
[23:29:49.308] Build status: SCHEDULED
[23:29:49.308] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:67:0) after 5m18s
[23:35:07.325] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:67:0)
[23:35:07.383] Build status: SCHEDULED
[23:35:07.383] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:68:0) after 4m26s
[23:39:33.488] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:68:0)
[23:39:33.508] Build status: SCHEDULED
[23:39:33.508] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:69:0) after 4m24s
[23:43:57.519] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:69:0)
[23:43:57.536] Build status: SCHEDULED
[23:43:57.536] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:70:0) after 2m49s
[23:46:46.518] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:70:0)
[23:46:46.536] Build status: SCHEDULED
[23:46:46.536] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:71:0) after 5m29s
[23:52:15.685] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:71:0)
[23:52:15.723] Build status: SCHEDULED
[23:52:15.723] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:72:0) after 9m9s
[00:01:24.742] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:72:0)
[00:01:24.838] Build status: SCHEDULED
[00:01:24.838] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:73:0) after 2m6s
[00:03:31.106] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:73:0)
[00:03:31.159] Build status: SCHEDULED
[00:03:31.159] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:74:0) after 9m13s
[00:12:44.250] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:74:0)
[00:12:44.276] Build status: SCHEDULED
[00:12:44.276] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:75:0) after 3m28s
[00:16:12.248] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:75:0)
[00:16:12.264] Build status: SCHEDULED
[00:16:12.265] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:76:0) after 4m18s
[00:20:30.424] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:76:0)
[00:20:30.453] Build status: SCHEDULED
[00:20:30.453] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:77:0) after 3m12s
[00:23:42.539] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:77:0)
[00:23:42.559] Build status: SCHEDULED
[00:23:42.559] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:78:0) after 1m40s
[00:25:22.741] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:78:0)
[00:25:22.760] Build status: SCHEDULED
[00:25:22.760] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:79:0) after 1m45s
[00:27:07.835] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:79:0)
[00:27:07.852] Build status: SCHEDULED
[00:27:07.852] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:80:0) after 1m16s
[00:28:24.056] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:80:0)
[00:28:24.115] Build status: SCHEDULED
[00:28:24.115] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:81:0) after 5m59s
[00:34:23.247] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:81:0)
[00:34:23.417] Build status: SCHEDULED
[00:34:23.417] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:82:0) after 1m4s
[00:35:27.428] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:82:0)
[00:35:27.447] Build status: SCHEDULED
[00:35:27.447] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:83:0) after 5m20s
[00:40:47.662] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:83:0)
[00:40:47.731] Build status: SCHEDULED
[00:40:47.731] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:84:0) after 8m6s
[00:48:53.746] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:84:0)
[00:48:53.771] Build status: SCHEDULED
[00:48:53.771] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:85:0) after 1m58s
[00:50:51.839] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:85:0)
[00:50:51.858] Build status: SCHEDULED
[00:50:51.859] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:86:0) after 1m18s
[00:52:09.924] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:86:0)
[00:52:09.947] Build status: SCHEDULED
[00:52:09.947] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:87:0) after 4m10s
[00:56:19.963] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:87:0)
[00:56:19.983] Build status: SCHEDULED
[00:56:19.983] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:88:0) after 2m48s
[00:59:08.341] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:88:0)
[00:59:08.366] Build status: SCHEDULED
[00:59:08.366] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:89:0) after 5m12s
[01:04:21.007] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:89:0)
[01:04:21.028] Build status: SCHEDULED
[01:04:21.028] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:90:0) after 5m34s
[01:09:55.965] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:90:0)
[01:09:55.994] Build status: SCHEDULED
[01:09:55.994] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:91:0) after 8m13s
[01:18:09.480] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:91:0)
[01:18:09.572] Build status: SCHEDULED
[01:18:09.572] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:92:0) after 4m48s
[01:22:57.732] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:92:0)
[01:22:57.755] Build status: SCHEDULED
[01:22:57.755] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:93:0) after 3m2s
[01:25:59.846] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:93:0)
[01:25:59.872] Build status: SCHEDULED
[01:25:59.872] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:94:0) after 3m35s
[01:29:35.044] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:94:0)
[01:29:35.069] Build status: SCHEDULED
[01:29:35.069] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:95:0) after 1m22s
[01:30:57.088] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:95:0)
[01:30:57.188] Build status: SCHEDULED
[01:30:57.189] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:96:0) after 7m52s
[01:38:50.062] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:96:0)
[01:38:50.107] Build status: SCHEDULED
[01:38:50.107] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:97:0) after 2m24s
[01:41:14.122] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:97:0)
[01:41:14.141] Build status: SCHEDULED
[01:41:14.141] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:98:0) after 1m24s
[01:42:38.206] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:98:0)
[01:42:38.225] Build status: SCHEDULED
[01:42:38.225] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:99:0) after 3m8s
[01:45:46.237] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:99:0)
[01:45:46.283] Build status: SCHEDULED
[01:45:46.283] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:100:0) after 5m0s
[01:50:46.540] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:100:0)
[01:50:46.626] Build status: SCHEDULED
[01:50:46.626] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:101:0) after 7m52s
[01:55:27.904] Received PubSub notification, asking Buildbucket for the build status
[01:55:27.923] Build status: STARTED
[01:58:38.789] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:101:0)
[01:58:38.809] Build status: STARTED
[01:58:38.809] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:103:0) after 9m13s
[02:07:51.991] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:103:0)
[02:07:52.022] Build status: STARTED
[02:07:52.022] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:104:0) after 8m11s
[02:16:03.017] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:104:0)
[02:16:03.040] Build status: STARTED
[02:16:03.040] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:105:0) after 4m33s
[02:20:36.054] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:105:0)
[02:20:36.114] Build status: STARTED
[02:20:36.114] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:106:0) after 3m52s
[02:24:28.132] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:106:0)
[02:24:28.178] Build status: STARTED
[02:24:28.178] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:107:0) after 4m29s
[02:28:57.196] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:107:0)
[02:28:57.216] Build status: STARTED
[02:28:57.217] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:108:0) after 9m20s
[02:38:17.242] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:108:0)
[02:38:17.263] Build status: STARTED
[02:38:17.263] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:109:0) after 1m1s
[02:39:18.513] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:109:0)
[02:39:18.529] Build status: STARTED
[02:39:18.529] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:110:0) after 9m21s
[02:48:39.595] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:110:0)
[02:48:39.612] Build status: STARTED
[02:48:39.612] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:111:0) after 3m29s
[02:52:08.725] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:111:0)
[02:52:08.749] Build status: STARTED
[02:52:08.749] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:112:0) after 1m8s
[02:53:16.762] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:112:0)
[02:53:16.778] Build status: STARTED
[02:53:16.778] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:113:0) after 7m44s
[03:01:00.793] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:113:0)
[03:01:00.812] Build status: STARTED
[03:01:00.812] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:114:0) after 1m14s
[03:02:14.943] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:114:0)
[03:02:14.958] Build status: STARTED
[03:02:14.958] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:115:0) after 1m55s
[03:04:09.975] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:115:0)
[03:04:10.006] Build status: STARTED
[03:04:10.006] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:116:0) after 2m33s
[03:06:43.020] Handling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:116:0)
[03:06:43.045] Build status: STARTED
[03:06:43.045] Scheduling timer "check-buildbucket-build-status" (r8/perf:8847600280178564816:117:0) after 3m46s
[03:08:11.142] Received PubSub notification, asking Buildbucket for the build status
[03:08:11.159] Build:
{
  "id": "8682170218324709697",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "perf"
  },
  "number": 2901,
  "createdBy": "project:r8",
  "createTime": "2026-05-10T17:31:14.324452666Z",
  "startTime": "2026-05-11T01:55:27.472039727Z",
  "endTime": "2026-05-11T03:08:10.894875670Z",
  "updateTime": "2026-05-11T03:08:10.894875670Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "5405d226baba0b87ea6a3f793ba7146ebf2ed1c6",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[03:08:11.159] Invocation finished in 9h36m57.986729935s with status SUCCEEDED