LUCI Scheduler :: r8 :: linux-internal

Status: FAILED

Triggered by: -

Duration: 8 hours

Actions:

Definition (rev 11ee884dc0e65548e1df5af19abf13230aecda6e)

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

Incoming triggers

9a5c4ca143800b6543f096ccf353f4ad9122b0b6 (2 years ago)
5e8e4bf716b99d3439ba14be2e8a836e5ae91d94 (2 years ago)
164ac5f25739761dacc27ec50c5838cacaa218dd (2 years ago)
5f2348c860eac774cb15c74eae4ff4e92191b527 (2 years ago)
8b452944fdfbb850046222d33357d21eea6acef5 (2 years ago)
b3352468ccd4f0b9851cf3d661203d6874f5b029 (2 years ago)
6b618fb57de003c4a65487b52b405f20ec88cfd7 (2 years ago)
1b0ba916e7865f82ce648979ba7c873f29f93720 (2 years ago)

Incoming properties

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

Incoming tags

buildset:commit/gitiles/r8.googlesource.com/r8/+/1b0ba916e7865f82ce648979ba7c873f29f93720
gitiles_ref:refs/heads/main

Debug log (UTC)

[16:13:00.114] New invocation is queued and will start shortly
[16:13:01.244] Starting the invocation (attempt 1)
[16:13:01.278] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/1b0ba916e7865f82ce648979ba7c873f29f93720"
[16:13:01.278] Popped gitiles commit info from properties and tags
[16:13:01.278] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:13:01.278] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:13:01.278] Buildbucket request:
{
  "requestId": "8937567988847121984",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8937567988847121984",
            "job": "r8/linux-internal",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "9a5c4ca143800b6543f096ccf353f4ad9122b0b6"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@9a5c4ca143800b6543f096ccf353f4ad9122b0b6",
                        "title": "9a5c4ca143800b6543f096ccf353f4ad9122b0b6",
                        "url": "https://r8.googlesource.com/r8/+/9a5c4ca143800b6543f096ccf353f4ad9122b0b6"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "5e8e4bf716b99d3439ba14be2e8a836e5ae91d94"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@5e8e4bf716b99d3439ba14be2e8a836e5ae91d94",
                        "title": "5e8e4bf716b99d3439ba14be2e8a836e5ae91d94",
                        "url": "https://r8.googlesource.com/r8/+/5e8e4bf716b99d3439ba14be2e8a836e5ae91d94"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "164ac5f25739761dacc27ec50c5838cacaa218dd"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@164ac5f25739761dacc27ec50c5838cacaa218dd",
                        "title": "164ac5f25739761dacc27ec50c5838cacaa218dd",
                        "url": "https://r8.googlesource.com/r8/+/164ac5f25739761dacc27ec50c5838cacaa218dd"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "5f2348c860eac774cb15c74eae4ff4e92191b527"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@5f2348c860eac774cb15c74eae4ff4e92191b527",
                        "title": "5f2348c860eac774cb15c74eae4ff4e92191b527",
                        "url": "https://r8.googlesource.com/r8/+/5f2348c860eac774cb15c74eae4ff4e92191b527"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "8b452944fdfbb850046222d33357d21eea6acef5"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@8b452944fdfbb850046222d33357d21eea6acef5",
                        "title": "8b452944fdfbb850046222d33357d21eea6acef5",
                        "url": "https://r8.googlesource.com/r8/+/8b452944fdfbb850046222d33357d21eea6acef5"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "b3352468ccd4f0b9851cf3d661203d6874f5b029"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@b3352468ccd4f0b9851cf3d661203d6874f5b029",
                        "title": "b3352468ccd4f0b9851cf3d661203d6874f5b029",
                        "url": "https://r8.googlesource.com/r8/+/b3352468ccd4f0b9851cf3d661203d6874f5b029"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "6b618fb57de003c4a65487b52b405f20ec88cfd7"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@6b618fb57de003c4a65487b52b405f20ec88cfd7",
                        "title": "6b618fb57de003c4a65487b52b405f20ec88cfd7",
                        "url": "https://r8.googlesource.com/r8/+/6b618fb57de003c4a65487b52b405f20ec88cfd7"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "1b0ba916e7865f82ce648979ba7c873f29f93720"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@1b0ba916e7865f82ce648979ba7c873f29f93720",
                        "title": "1b0ba916e7865f82ce648979ba7c873f29f93720",
                        "url": "https://r8.googlesource.com/r8/+/1b0ba916e7865f82ce648979ba7c873f29f93720"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "1b0ba916e7865f82ce648979ba7c873f29f93720",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8937567988847121984"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/linux-internal"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[16:13:02.078] Scheduled build:
{
  "id": "8772137926907258417",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 3409,
  "createdBy": "project:r8",
  "createTime": "2023-08-21T16:13:01.343160151Z",
  "updateTime": "2023-08-21T16:13:01.343160151Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "1b0ba916e7865f82ce648979ba7c873f29f93720",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[16:13:02.078] Task URL: https://cr-buildbucket.appspot.com/build/8772137926907258417
[16:13:02.078] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:2:0) after 5m55s
[16:13:03.207] Received PubSub notification, asking Buildbucket for the build status
[16:13:03.240] Build status: SCHEDULED
[16:14:10.438] Received PubSub notification, asking Buildbucket for the build status
[16:14:10.491] Build status: STARTED
[16:18:57.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:2:0)
[16:18:57.305] Build status: STARTED
[16:18:57.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:5:0) after 5m40s
[16:24:37.324] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:5:0)
[16:24:37.361] Build status: STARTED
[16:24:37.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:6:0) after 7m27s
[16:32:04.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:6:0)
[16:32:04.430] Build status: STARTED
[16:32:04.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:7:0) after 5m8s
[16:37:12.449] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:7:0)
[16:37:12.535] Build status: STARTED
[16:37:12.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:8:0) after 8m16s
[16:45:28.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:8:0)
[16:45:28.722] Build status: STARTED
[16:45:28.722] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:9:0) after 2m48s
[16:48:17.183] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:9:0)
[16:48:17.201] Build status: STARTED
[16:48:17.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:10:0) after 4m42s
[16:52:59.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:10:0)
[16:52:59.947] Build status: STARTED
[16:52:59.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:11:0) after 8m15s
[17:01:15.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:11:0)
[17:01:15.187] Build status: STARTED
[17:01:15.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:12:0) after 6m18s
[17:07:33.206] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:12:0)
[17:07:33.237] Build status: STARTED
[17:07:33.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:13:0) after 9m44s
[17:17:17.732] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:13:0)
[17:17:17.763] Build status: STARTED
[17:17:17.763] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:14:0) after 7m54s
[17:25:12.183] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:14:0)
[17:25:12.216] Build status: STARTED
[17:25:12.217] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:15:0) after 7m3s
[17:32:15.210] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:15:0)
[17:32:15.231] Build status: STARTED
[17:32:15.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:16:0) after 9m11s
[17:41:26.324] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:16:0)
[17:41:26.362] Build status: STARTED
[17:41:26.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:17:0) after 4m25s
[17:45:51.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:17:0)
[17:45:51.727] Build status: STARTED
[17:45:51.727] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:18:0) after 2m12s
[17:48:03.707] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:18:0)
[17:48:03.741] Build status: STARTED
[17:48:03.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:19:0) after 7m22s
[17:55:25.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:19:0)
[17:55:25.795] Build status: STARTED
[17:55:25.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:20:0) after 5m40s
[18:01:05.831] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:20:0)
[18:01:05.855] Build status: STARTED
[18:01:05.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:21:0) after 7m21s
[18:08:26.938] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:21:0)
[18:08:26.960] Build status: STARTED
[18:08:26.960] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:22:0) after 9m22s
[18:17:49.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:22:0)
[18:17:49.286] Build status: STARTED
[18:17:49.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:23:0) after 6m49s
[18:24:38.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:23:0)
[18:24:38.403] Build status: STARTED
[18:24:38.403] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:24:0) after 7m20s
[18:31:58.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:24:0)
[18:31:58.658] Build status: STARTED
[18:31:58.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:25:0) after 9m35s
[18:41:33.727] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:25:0)
[18:41:33.765] Build status: STARTED
[18:41:33.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:26:0) after 6m33s
[18:48:06.915] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:26:0)
[18:48:07.013] Build status: STARTED
[18:48:07.013] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:27:0) after 4m0s
[18:52:07.534] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:27:0)
[18:52:07.619] Build status: STARTED
[18:52:07.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:28:0) after 7m18s
[18:59:25.636] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:28:0)
[18:59:25.658] Build status: STARTED
[18:59:25.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:29:0) after 3m37s
[19:03:02.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:29:0)
[19:03:02.970] Build status: STARTED
[19:03:02.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:30:0) after 3m0s
[19:06:03.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:30:0)
[19:06:03.167] Build status: STARTED
[19:06:03.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:31:0) after 8m10s
[19:14:13.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:31:0)
[19:14:13.331] Build status: STARTED
[19:14:13.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:32:0) after 2m9s
[19:16:22.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:32:0)
[19:16:22.327] Build status: STARTED
[19:16:22.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:33:0) after 6m38s
[19:23:00.473] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:33:0)
[19:23:00.497] Build status: STARTED
[19:23:00.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:34:0) after 4m43s
[19:27:43.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:34:0)
[19:27:43.545] Build status: STARTED
[19:27:43.545] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:35:0) after 6m58s
[19:34:41.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:35:0)
[19:34:41.780] Build status: STARTED
[19:34:41.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:36:0) after 9m33s
[19:44:14.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:36:0)
[19:44:14.960] Build status: STARTED
[19:44:14.960] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:37:0) after 9m10s
[19:53:24.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:37:0)
[19:53:25.033] Build status: STARTED
[19:53:25.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:38:0) after 8m53s
[20:02:18.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:38:0)
[20:02:18.108] Build status: STARTED
[20:02:18.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:39:0) after 6m0s
[20:08:18.353] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:39:0)
[20:08:18.375] Build status: STARTED
[20:08:18.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:40:0) after 3m45s
[20:12:03.490] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:40:0)
[20:12:03.530] Build status: STARTED
[20:12:03.530] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:41:0) after 7m23s
[20:19:26.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:41:0)
[20:19:26.591] Build status: STARTED
[20:19:26.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:42:0) after 3m55s
[20:23:22.503] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:42:0)
[20:23:22.519] Build status: STARTED
[20:23:22.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:43:0) after 6m26s
[20:29:48.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:43:0)
[20:29:49.141] Build status: STARTED
[20:29:49.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:44:0) after 2m0s
[20:31:49.180] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:44:0)
[20:31:49.210] Build status: STARTED
[20:31:49.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:45:0) after 4m19s
[20:36:08.687] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:45:0)
[20:36:08.706] Build status: STARTED
[20:36:08.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:46:0) after 2m9s
[20:38:17.876] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:46:0)
[20:38:17.895] Build status: STARTED
[20:38:17.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:47:0) after 5m5s
[20:43:22.986] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:47:0)
[20:43:23.048] Build status: STARTED
[20:43:23.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:48:0) after 5m29s
[20:48:52.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:48:0)
[20:48:52.120] Build status: STARTED
[20:48:52.120] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:49:0) after 3m50s
[20:52:42.141] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:49:0)
[20:52:42.181] Build status: STARTED
[20:52:42.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:50:0) after 4m24s
[20:57:06.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:50:0)
[20:57:06.556] Build status: STARTED
[20:57:06.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:51:0) after 6m16s
[21:03:22.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:51:0)
[21:03:22.904] Build status: STARTED
[21:03:22.904] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:52:0) after 9m12s
[21:12:34.995] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:52:0)
[21:12:35.056] Build status: STARTED
[21:12:35.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:53:0) after 5m35s
[21:18:10.075] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:53:0)
[21:18:10.100] Build status: STARTED
[21:18:10.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:54:0) after 2m24s
[21:20:34.151] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:54:0)
[21:20:34.178] Build status: STARTED
[21:20:34.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:55:0) after 6m14s
[21:26:48.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:55:0)
[21:26:48.243] Build status: STARTED
[21:26:48.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:56:0) after 8m11s
[21:34:59.320] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:56:0)
[21:34:59.358] Build status: STARTED
[21:34:59.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:57:0) after 7m54s
[21:42:54.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:57:0)
[21:42:54.074] Build status: STARTED
[21:42:54.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:58:0) after 4m44s
[21:47:38.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:58:0)
[21:47:38.117] Build status: STARTED
[21:47:38.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:59:0) after 9m30s
[21:57:08.235] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:59:0)
[21:57:08.265] Build status: STARTED
[21:57:08.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:60:0) after 1m13s
[21:58:21.337] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:60:0)
[21:58:21.361] Build status: STARTED
[21:58:21.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:61:0) after 1m5s
[21:59:26.853] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:61:0)
[21:59:26.884] Build status: STARTED
[21:59:26.884] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:62:0) after 8m22s
[22:07:48.902] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:62:0)
[22:07:48.939] Build status: STARTED
[22:07:48.939] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:63:0) after 3m41s
[22:11:30.442] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:63:0)
[22:11:30.474] Build status: STARTED
[22:11:30.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:64:0) after 7m48s
[22:19:18.491] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:64:0)
[22:19:18.519] Build status: STARTED
[22:19:18.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:65:0) after 3m1s
[22:22:19.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:65:0)
[22:22:19.569] Build status: STARTED
[22:22:19.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:66:0) after 9m41s
[22:32:00.595] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:66:0)
[22:32:00.614] Build status: STARTED
[22:32:00.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:67:0) after 8m46s
[22:40:46.636] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:67:0)
[22:40:46.663] Build status: STARTED
[22:40:46.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:68:0) after 5m43s
[22:46:29.868] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:68:0)
[22:46:29.905] Build status: STARTED
[22:46:29.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:69:0) after 7m59s
[22:54:29.019] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:69:0)
[22:54:29.051] Build status: STARTED
[22:54:29.051] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:70:0) after 3m57s
[22:58:26.121] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:70:0)
[22:58:26.198] Build status: STARTED
[22:58:26.198] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:71:0) after 8m12s
[23:06:38.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:71:0)
[23:06:38.260] Build status: STARTED
[23:06:38.260] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:72:0) after 6m19s
[23:12:57.279] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:72:0)
[23:12:57.300] Build status: STARTED
[23:12:57.300] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:73:0) after 4m11s
[23:17:08.369] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:73:0)
[23:17:08.405] Build status: STARTED
[23:17:08.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:74:0) after 8m10s
[23:25:18.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:74:0)
[23:25:18.487] Build status: STARTED
[23:25:18.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:75:0) after 7m36s
[23:32:54.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:75:0)
[23:32:54.622] Build status: STARTED
[23:32:54.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:76:0) after 9m46s
[23:42:41.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:76:0)
[23:42:41.033] Build status: STARTED
[23:42:41.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:77:0) after 7m43s
[23:50:24.396] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:77:0)
[23:50:24.455] Build status: STARTED
[23:50:24.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:78:0) after 6m1s
[23:56:25.602] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:78:0)
[23:56:25.635] Build status: STARTED
[23:56:25.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:79:0) after 3m40s
[00:00:05.709] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:79:0)
[00:00:05.768] Build status: STARTED
[00:00:05.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:80:0) after 8m15s
[00:08:20.887] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:80:0)
[00:08:20.906] Build status: STARTED
[00:08:20.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:81:0) after 6m30s
[00:14:50.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:81:0)
[00:14:51.061] Build status: STARTED
[00:14:51.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:82:0) after 1m9s
[00:16:00.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:82:0)
[00:16:00.256] Build status: STARTED
[00:16:00.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:83:0) after 1m56s
[00:17:56.394] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:83:0)
[00:17:56.462] Build status: STARTED
[00:17:56.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:84:0) after 6m47s
[00:24:43.872] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:84:0)
[00:24:43.909] Build status: STARTED
[00:24:43.909] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:85:0) after 1m28s
[00:26:11.927] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:85:0)
[00:26:11.958] Build status: STARTED
[00:26:11.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8937567988847121984:86:0) after 4m39s
[00:30:46.380] Received PubSub notification, asking Buildbucket for the build status
[00:30:46.407] Build:
{
  "id": "8772137926907258417",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 3409,
  "createdBy": "project:r8",
  "createTime": "2023-08-21T16:13:01.343160151Z",
  "startTime": "2023-08-21T16:14:09.616195Z",
  "endTime": "2023-08-22T00:30:40.375476959Z",
  "updateTime": "2023-08-22T00:30:40.375476959Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "1b0ba916e7865f82ce648979ba7c873f29f93720",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[00:30:46.407] Invocation finished in 8h17m46.298311303s with status FAILED