Status: SUCCEEDED
Triggered by: -
Duration: 13 hours
Actions:

Definition (rev 50d64388525a75bb410b0db60066f545d3fa17ba)

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

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/3.2",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503"
}

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503
  • gitiles_ref:refs/heads/3.2

Debug log (UTC)

[17:03:29.925] New invocation is queued and will start shortly
[17:03:31.494] Starting the invocation (attempt 1)
[17:03:31.548] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503"
[17:03:31.549] Popped gitiles commit info from properties and tags
[17:03:31.549] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:03:31.549] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:03:31.549] Buildbucket request:
{
  "requestId": "8980054789112825456",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-none_release"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8980054789112825456",
            "job": "r8/linux-none_release",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/3.2",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/3.2@34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503",
                        "title": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503",
                        "url": "https://r8.googlesource.com/r8/+/34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503",
    "ref": "refs/heads/3.2"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8980054789112825456"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/linux-none_release"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[17:03:32.359] Scheduled build:
{
  "id": "8814624726599429489",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-none_release"
  },
  "number": 267,
  "createdBy": "project:r8",
  "createTime": "2022-05-09T17:03:31.690945498Z",
  "updateTime": "2022-05-09T17:03:31.690945498Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503",
      "ref": "refs/heads/3.2"
    }
  },
  "canary": true
}
[17:03:32.359] Task URL: https://cr-buildbucket.appspot.com/build/8814624726599429489
[17:03:32.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:2:0) after 7m15s
[17:10:47.379] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:2:0)
[17:10:47.490] Build status: SCHEDULED
[17:10:47.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:3:0) after 8m47s
[17:19:34.483] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:3:0)
[17:19:34.515] Build status: SCHEDULED
[17:19:34.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:4:0) after 3m16s
[17:22:50.530] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:4:0)
[17:22:50.557] Build status: SCHEDULED
[17:22:50.557] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:5:0) after 7m56s
[17:30:46.574] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:5:0)
[17:30:46.605] Build status: SCHEDULED
[17:30:46.605] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:6:0) after 9m57s
[17:40:43.622] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:6:0)
[17:40:43.677] Build status: SCHEDULED
[17:40:43.677] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:7:0) after 9m10s
[17:49:53.695] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:7:0)
[17:49:53.743] Build status: SCHEDULED
[17:49:53.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:8:0) after 9m59s
[17:59:52.763] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:8:0)
[17:59:52.793] Build status: SCHEDULED
[17:59:52.794] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:9:0) after 7m24s
[18:07:17.078] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:9:0)
[18:07:17.114] Build status: SCHEDULED
[18:07:17.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:10:0) after 8m56s
[18:16:13.186] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:10:0)
[18:16:13.231] Build status: SCHEDULED
[18:16:13.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:11:0) after 5m39s
[18:21:52.538] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:11:0)
[18:21:52.564] Build status: SCHEDULED
[18:21:52.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:12:0) after 4m26s
[18:26:18.652] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:12:0)
[18:26:18.685] Build status: SCHEDULED
[18:26:18.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:13:0) after 6m40s
[18:32:58.708] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:13:0)
[18:32:58.787] Build status: SCHEDULED
[18:32:58.788] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:14:0) after 8m1s
[18:40:59.862] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:14:0)
[18:40:59.896] Build status: SCHEDULED
[18:40:59.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:15:0) after 4m40s
[18:45:39.913] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:15:0)
[18:45:39.943] Build status: SCHEDULED
[18:45:39.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:16:0) after 9m14s
[18:54:54.266] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:16:0)
[18:54:54.302] Build status: SCHEDULED
[18:54:54.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:17:0) after 7m15s
[19:02:09.864] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:17:0)
[19:02:09.906] Build status: SCHEDULED
[19:02:09.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:18:0) after 9m12s
[19:11:22.253] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:18:0)
[19:11:22.279] Build status: SCHEDULED
[19:11:22.279] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:19:0) after 5m44s
[19:17:06.314] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:19:0)
[19:17:06.348] Build status: SCHEDULED
[19:17:06.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:20:0) after 5m22s
[19:22:28.418] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:20:0)
[19:22:28.450] Build status: SCHEDULED
[19:22:28.450] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:21:0) after 4m7s
[19:26:35.469] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:21:0)
[19:26:35.520] Build status: SCHEDULED
[19:26:35.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:22:0) after 6m6s
[19:32:42.138] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:22:0)
[19:32:42.167] Build status: SCHEDULED
[19:32:42.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:23:0) after 8m46s
[19:41:28.206] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:23:0)
[19:41:28.236] Build status: SCHEDULED
[19:41:28.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:24:0) after 2m39s
[19:44:07.417] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:24:0)
[19:44:07.447] Build status: SCHEDULED
[19:44:07.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:25:0) after 8m26s
[19:52:33.563] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:25:0)
[19:52:33.596] Build status: SCHEDULED
[19:52:33.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:26:0) after 4m16s
[19:56:49.614] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:26:0)
[19:56:49.649] Build status: SCHEDULED
[19:56:49.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:27:0) after 9m14s
[20:06:03.677] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:27:0)
[20:06:03.706] Build status: SCHEDULED
[20:06:03.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:28:0) after 3m52s
[20:09:55.819] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:28:0)
[20:09:55.852] Build status: SCHEDULED
[20:09:55.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:29:0) after 2m52s
[20:12:49.039] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:29:0)
[20:12:49.077] Build status: SCHEDULED
[20:12:49.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:30:0) after 2m9s
[20:14:58.121] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:30:0)
[20:14:58.155] Build status: SCHEDULED
[20:14:58.155] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:31:0) after 5m6s
[20:20:04.206] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:31:0)
[20:20:04.238] Build status: SCHEDULED
[20:20:04.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:32:0) after 3m35s
[20:23:39.302] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:32:0)
[20:23:39.369] Build status: SCHEDULED
[20:23:39.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:33:0) after 4m39s
[20:28:18.482] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:33:0)
[20:28:18.567] Build status: SCHEDULED
[20:28:18.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:34:0) after 9m11s
[20:37:29.613] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:34:0)
[20:37:29.631] Build status: SCHEDULED
[20:37:29.631] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:35:0) after 6m30s
[20:43:59.651] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:35:0)
[20:43:59.675] Build status: SCHEDULED
[20:43:59.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:36:0) after 6m38s
[20:50:37.753] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:36:0)
[20:50:37.784] Build status: SCHEDULED
[20:50:37.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:37:0) after 3m41s
[20:54:18.852] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:37:0)
[20:54:18.911] Build status: SCHEDULED
[20:54:18.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:38:0) after 8m47s
[21:03:05.932] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:38:0)
[21:03:05.967] Build status: SCHEDULED
[21:03:05.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:39:0) after 4m8s
[21:07:13.988] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:39:0)
[21:07:14.025] Build status: SCHEDULED
[21:07:14.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:40:0) after 9m44s
[21:16:58.097] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:40:0)
[21:16:58.158] Build status: SCHEDULED
[21:16:58.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:41:0) after 5m59s
[21:22:57.270] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:41:0)
[21:22:57.299] Build status: SCHEDULED
[21:22:57.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:42:0) after 5m18s
[21:28:15.320] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:42:0)
[21:28:15.352] Build status: SCHEDULED
[21:28:15.352] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:43:0) after 3m58s
[21:32:13.373] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:43:0)
[21:32:13.407] Build status: SCHEDULED
[21:32:13.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:44:0) after 8m10s
[21:40:23.531] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:44:0)
[21:40:23.560] Build status: SCHEDULED
[21:40:23.560] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:45:0) after 4m46s
[21:45:09.768] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:45:0)
[21:45:09.818] Build status: SCHEDULED
[21:45:09.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:46:0) after 3m17s
[21:48:26.903] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:46:0)
[21:48:26.938] Build status: SCHEDULED
[21:48:26.938] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:47:0) after 7m58s
[21:56:25.269] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:47:0)
[21:56:25.289] Build status: SCHEDULED
[21:56:25.289] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:48:0) after 7m45s
[22:04:10.619] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:48:0)
[22:04:10.651] Build status: SCHEDULED
[22:04:10.651] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:49:0) after 2m50s
[22:07:00.991] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:49:0)
[22:07:01.022] Build status: SCHEDULED
[22:07:01.022] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:50:0) after 5m59s
[22:13:00.473] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:50:0)
[22:13:00.526] Build status: SCHEDULED
[22:13:00.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:51:0) after 8m48s
[22:21:48.560] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:51:0)
[22:21:48.597] Build status: SCHEDULED
[22:21:48.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:52:0) after 3m42s
[22:25:30.649] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:52:0)
[22:25:30.699] Build status: SCHEDULED
[22:25:30.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:53:0) after 4m53s
[22:30:23.739] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:53:0)
[22:30:23.790] Build status: SCHEDULED
[22:30:23.790] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:54:0) after 8m55s
[22:39:18.858] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:54:0)
[22:39:18.885] Build status: SCHEDULED
[22:39:18.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:55:0) after 2m33s
[22:41:52.043] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:55:0)
[22:41:52.083] Build status: SCHEDULED
[22:41:52.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:56:0) after 2m18s
[22:44:10.230] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:56:0)
[22:44:10.291] Build status: SCHEDULED
[22:44:10.291] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:57:0) after 3m13s
[22:47:23.374] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:57:0)
[22:47:23.416] Build status: SCHEDULED
[22:47:23.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:58:0) after 2m11s
[22:49:34.443] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:58:0)
[22:49:34.466] Build status: SCHEDULED
[22:49:34.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:59:0) after 7m26s
[22:57:00.801] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:59:0)
[22:57:00.836] Build status: SCHEDULED
[22:57:00.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:60:0) after 8m34s
[23:06:43.288] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:60:0)
[23:06:43.406] Build status: SCHEDULED
[23:06:43.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:61:0) after 6m17s
[23:13:00.604] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:61:0)
[23:13:00.949] Build status: SCHEDULED
[23:13:00.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:62:0) after 5m18s
[23:18:18.969] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:62:0)
[23:18:19.050] Build status: SCHEDULED
[23:18:19.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:63:0) after 9m16s
[23:27:35.242] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:63:0)
[23:27:35.269] Build status: SCHEDULED
[23:27:35.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:64:0) after 3m42s
[23:31:17.298] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:64:0)
[23:31:17.330] Build status: SCHEDULED
[23:31:17.330] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:65:0) after 8m22s
[23:39:39.485] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:65:0)
[23:39:39.536] Build status: SCHEDULED
[23:39:39.536] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:66:0) after 7m27s
[23:47:06.663] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:66:0)
[23:47:06.693] Build status: SCHEDULED
[23:47:06.693] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:67:0) after 4m17s
[23:51:23.962] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:67:0)
[23:51:23.989] Build status: SCHEDULED
[23:51:23.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:68:0) after 4m19s
[23:55:43.018] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:68:0)
[23:55:43.036] Build status: SCHEDULED
[23:55:43.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:69:0) after 3m32s
[23:59:15.356] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:69:0)
[23:59:15.400] Build status: SCHEDULED
[23:59:15.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:70:0) after 4m50s
[00:04:05.419] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:70:0)
[00:04:05.447] Build status: SCHEDULED
[00:04:05.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:71:0) after 3m52s
[00:07:57.908] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:71:0)
[00:07:57.944] Build status: SCHEDULED
[00:07:57.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:72:0) after 2m39s
[00:10:36.999] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:72:0)
[00:10:37.027] Build status: SCHEDULED
[00:10:37.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:73:0) after 1m34s
[00:12:11.112] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:73:0)
[00:12:11.145] Build status: SCHEDULED
[00:12:11.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:74:0) after 8m17s
[00:20:28.133] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:74:0)
[00:20:28.164] Build status: SCHEDULED
[00:20:28.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:75:0) after 7m29s
[00:27:57.273] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:75:0)
[00:27:57.303] Build status: SCHEDULED
[00:27:57.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:76:0) after 1m32s
[00:29:29.322] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:76:0)
[00:29:29.407] Build status: SCHEDULED
[00:29:29.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:77:0) after 2m30s
[00:31:59.528] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:77:0)
[00:31:59.559] Build status: SCHEDULED
[00:31:59.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:78:0) after 7m29s
[00:39:28.681] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:78:0)
[00:39:28.717] Build status: SCHEDULED
[00:39:28.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:79:0) after 7m41s
[00:47:09.740] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:79:0)
[00:47:09.771] Build status: SCHEDULED
[00:47:09.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:80:0) after 6m3s
[00:53:12.978] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:80:0)
[00:53:13.007] Build status: SCHEDULED
[00:53:13.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:81:0) after 7m4s
[01:00:17.052] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:81:0)
[01:00:17.083] Build status: SCHEDULED
[01:00:17.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:82:0) after 6m38s
[01:06:55.409] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:82:0)
[01:06:55.445] Build status: SCHEDULED
[01:06:55.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:83:0) after 1m9s
[01:08:04.464] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:83:0)
[01:08:04.507] Build status: SCHEDULED
[01:08:04.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:84:0) after 4m44s
[01:12:48.554] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:84:0)
[01:12:48.636] Build status: SCHEDULED
[01:12:48.636] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:85:0) after 3m52s
[01:16:40.695] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:85:0)
[01:16:40.726] Build status: SCHEDULED
[01:16:40.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:86:0) after 9m1s
[01:25:41.746] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:86:0)
[01:25:41.792] Build status: SCHEDULED
[01:25:41.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:87:0) after 2m51s
[01:28:32.844] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:87:0)
[01:28:32.866] Build status: SCHEDULED
[01:28:32.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:88:0) after 4m44s
[01:33:17.029] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:88:0)
[01:33:17.140] Build status: SCHEDULED
[01:33:17.140] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:89:0) after 7m48s
[01:41:05.244] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:89:0)
[01:41:05.265] Build status: SCHEDULED
[01:41:05.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:90:0) after 2m9s
[01:43:14.316] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:90:0)
[01:43:14.346] Build status: SCHEDULED
[01:43:14.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:91:0) after 9m44s
[01:52:58.411] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:91:0)
[01:52:58.456] Build status: SCHEDULED
[01:52:58.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:92:0) after 9m26s
[02:02:24.656] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:92:0)
[02:02:24.698] Build status: SCHEDULED
[02:02:24.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:93:0) after 9m55s
[02:12:19.758] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:93:0)
[02:12:19.794] Build status: SCHEDULED
[02:12:19.794] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:94:0) after 2m7s
[02:14:26.951] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:94:0)
[02:14:26.981] Build status: SCHEDULED
[02:14:26.981] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:95:0) after 1m11s
[02:15:38.002] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:95:0)
[02:15:38.097] Build status: SCHEDULED
[02:15:38.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:96:0) after 3m21s
[02:18:59.472] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:96:0)
[02:18:59.502] Build status: SCHEDULED
[02:18:59.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:97:0) after 8m30s
[02:27:29.592] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:97:0)
[02:27:29.625] Build status: SCHEDULED
[02:27:29.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:98:0) after 6m20s
[02:33:49.861] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:98:0)
[02:33:49.893] Build status: SCHEDULED
[02:33:49.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:99:0) after 5m6s
[02:38:55.952] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:99:0)
[02:38:55.981] Build status: SCHEDULED
[02:38:55.981] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:100:0) after 2m21s
[02:41:17.005] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:100:0)
[02:41:17.052] Build status: SCHEDULED
[02:41:17.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:101:0) after 3m14s
[02:44:31.081] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:101:0)
[02:44:31.148] Build status: SCHEDULED
[02:44:31.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:102:0) after 5m48s
[02:50:19.484] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:102:0)
[02:50:19.516] Build status: SCHEDULED
[02:50:19.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:103:0) after 8m20s
[02:58:39.492] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:103:0)
[02:58:39.512] Build status: SCHEDULED
[02:58:39.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:104:0) after 7m32s
[03:06:11.581] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:104:0)
[03:06:11.626] Build status: SCHEDULED
[03:06:11.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:105:0) after 7m45s
[03:13:56.958] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:105:0)
[03:13:56.989] Build status: SCHEDULED
[03:13:56.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:106:0) after 5m54s
[03:19:51.083] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:106:0)
[03:19:51.130] Build status: SCHEDULED
[03:19:51.130] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:107:0) after 4m9s
[03:24:00.642] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:107:0)
[03:24:00.693] Build status: SCHEDULED
[03:24:00.693] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:108:0) after 1m38s
[03:25:38.740] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:108:0)
[03:25:38.771] Build status: SCHEDULED
[03:25:38.771] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:109:0) after 9m16s
[03:34:54.796] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:109:0)
[03:34:54.827] Build status: SCHEDULED
[03:34:54.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:110:0) after 7m54s
[03:42:48.931] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:110:0)
[03:42:48.957] Build status: SCHEDULED
[03:42:48.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:111:0) after 8m32s
[03:51:21.313] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:111:0)
[03:51:21.345] Build status: SCHEDULED
[03:51:21.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:112:0) after 4m12s
[03:55:33.442] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:112:0)
[03:55:33.470] Build status: SCHEDULED
[03:55:33.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:113:0) after 5m54s
[04:01:27.831] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:113:0)
[04:01:27.856] Build status: SCHEDULED
[04:01:27.856] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:114:0) after 7m9s
[04:08:36.976] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:114:0)
[04:08:36.999] Build status: SCHEDULED
[04:08:36.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:115:0) after 3m2s
[04:11:39.458] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:115:0)
[04:11:39.481] Build status: SCHEDULED
[04:11:39.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:116:0) after 2m52s
[04:14:31.595] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:116:0)
[04:14:31.626] Build status: SCHEDULED
[04:14:31.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:117:0) after 8m5s
[04:22:36.703] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:117:0)
[04:22:36.734] Build status: SCHEDULED
[04:22:36.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:118:0) after 7m15s
[04:29:51.846] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:118:0)
[04:29:51.875] Build status: SCHEDULED
[04:29:51.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:119:0) after 6m27s
[04:36:19.096] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:119:0)
[04:36:19.148] Build status: SCHEDULED
[04:36:19.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:120:0) after 8m33s
[04:44:52.457] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:120:0)
[04:44:52.486] Build status: SCHEDULED
[04:44:52.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:121:0) after 3m54s
[04:48:46.472] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:121:0)
[04:48:46.504] Build status: SCHEDULED
[04:48:46.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:122:0) after 1m42s
[04:50:28.621] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:122:0)
[04:50:28.681] Build status: SCHEDULED
[04:50:28.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:123:0) after 7m22s
[04:57:50.709] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:123:0)
[04:57:50.774] Build status: SCHEDULED
[04:57:50.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:124:0) after 7m19s
[05:05:08.126] Received PubSub notification, asking Buildbucket for the build status
[05:05:08.176] Build status: STARTED
[05:05:09.796] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:124:0)
[05:05:09.832] Build status: STARTED
[05:05:09.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:126:0) after 3m34s
[05:08:43.994] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:126:0)
[05:08:44.025] Build status: STARTED
[05:08:44.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:127:0) after 5m25s
[05:14:09.046] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:127:0)
[05:14:09.077] Build status: STARTED
[05:14:09.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:128:0) after 7m41s
[05:21:50.084] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:128:0)
[05:21:50.137] Build status: STARTED
[05:21:50.137] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:129:0) after 6m43s
[05:28:33.160] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:129:0)
[05:28:33.205] Build status: STARTED
[05:28:33.205] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:130:0) after 8m13s
[05:36:46.225] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:130:0)
[05:36:46.264] Build status: STARTED
[05:36:46.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:131:0) after 4m42s
[05:41:28.444] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:131:0)
[05:41:28.489] Build status: STARTED
[05:41:28.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:132:0) after 1m41s
[05:43:09.526] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:132:0)
[05:43:09.584] Build status: STARTED
[05:43:09.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:133:0) after 2m43s
[05:45:52.606] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:133:0)
[05:45:52.638] Build status: STARTED
[05:45:52.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:134:0) after 9m2s
[05:54:54.670] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:134:0)
[05:54:54.705] Build status: STARTED
[05:54:54.705] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:135:0) after 3m17s
[05:58:11.728] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:135:0)
[05:58:11.769] Build status: STARTED
[05:58:11.769] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8980054789112825456:136:0) after 9m30s
[06:07:15.324] Received PubSub notification, asking Buildbucket for the build status
[06:07:15.353] Build:
{
  "id": "8814624726599429489",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-none_release"
  },
  "number": 267,
  "createdBy": "project:r8",
  "createTime": "2022-05-09T17:03:31.690945498Z",
  "startTime": "2022-05-10T05:05:07.153737Z",
  "endTime": "2022-05-10T06:07:14.990950153Z",
  "updateTime": "2022-05-10T06:07:14.990950153Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "34c1ec3be5650cf55c62c0a4c5dd1f35f85f9503",
      "ref": "refs/heads/3.2"
    }
  },
  "canary": true
}
[06:07:15.353] Invocation finished in 13h3m45.443472264s with status SUCCEEDED