Status: FAILED
Triggered by: -
Duration: 6 hours
Actions:

Definition (rev 11ee884dc0e65548e1df5af19abf13230aecda6e)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[14:14:30.989] New invocation is queued and will start shortly
[14:14:32.207] Starting the invocation (attempt 1)
[14:14:32.232] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/2d8c93fe249ac143a8ae9966e85ea1d387b897bc"
[14:14:32.232] Popped gitiles commit info from properties and tags
[14:14:32.232] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:14:32.232] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:14:32.233] Buildbucket request:
{
  "requestId": "8945547976359162496",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8945547976359162496",
            "job": "r8/linux-internal",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "c04d3081588215d84950f95d2e99f5a33237c665"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@c04d3081588215d84950f95d2e99f5a33237c665",
                        "title": "c04d3081588215d84950f95d2e99f5a33237c665",
                        "url": "https://r8.googlesource.com/r8/+/c04d3081588215d84950f95d2e99f5a33237c665"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "8c5f7b431c07055837e75433dd81d3f54a871427"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@8c5f7b431c07055837e75433dd81d3f54a871427",
                        "title": "8c5f7b431c07055837e75433dd81d3f54a871427",
                        "url": "https://r8.googlesource.com/r8/+/8c5f7b431c07055837e75433dd81d3f54a871427"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "67f49459987b1833eb8e1df6bf88744e878f6c92"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@67f49459987b1833eb8e1df6bf88744e878f6c92",
                        "title": "67f49459987b1833eb8e1df6bf88744e878f6c92",
                        "url": "https://r8.googlesource.com/r8/+/67f49459987b1833eb8e1df6bf88744e878f6c92"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "1f91421a378680de169d636f31e1309a854cf3c1"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@1f91421a378680de169d636f31e1309a854cf3c1",
                        "title": "1f91421a378680de169d636f31e1309a854cf3c1",
                        "url": "https://r8.googlesource.com/r8/+/1f91421a378680de169d636f31e1309a854cf3c1"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "d4b1b5cde09d67a3b7cffed31c6d1cd5aba3ca5d"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@d4b1b5cde09d67a3b7cffed31c6d1cd5aba3ca5d",
                        "title": "d4b1b5cde09d67a3b7cffed31c6d1cd5aba3ca5d",
                        "url": "https://r8.googlesource.com/r8/+/d4b1b5cde09d67a3b7cffed31c6d1cd5aba3ca5d"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "2d8c93fe249ac143a8ae9966e85ea1d387b897bc"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@2d8c93fe249ac143a8ae9966e85ea1d387b897bc",
                        "title": "2d8c93fe249ac143a8ae9966e85ea1d387b897bc",
                        "url": "https://r8.googlesource.com/r8/+/2d8c93fe249ac143a8ae9966e85ea1d387b897bc"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "2d8c93fe249ac143a8ae9966e85ea1d387b897bc",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8945547976359162496"
    },
    {
      "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"
  }
}
[14:14:32.637] Scheduled build:
{
  "id": "8780117914299909297",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 3265,
  "createdBy": "project:r8",
  "createTime": "2023-05-25T14:14:32.321371464Z",
  "updateTime": "2023-05-25T14:14:32.321371464Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "2d8c93fe249ac143a8ae9966e85ea1d387b897bc",
      "ref": "refs/heads/main"
    }
  }
}
[14:14:32.637] Task URL: https://cr-buildbucket.appspot.com/build/8780117914299909297
[14:14:32.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:2:0) after 7m55s
[14:22:27.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:2:0)
[14:22:27.808] Build status: SCHEDULED
[14:22:27.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:3:0) after 6m58s
[14:29:25.916] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:3:0)
[14:29:25.936] Build status: SCHEDULED
[14:29:25.936] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:4:0) after 5m40s
[14:35:06.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:4:0)
[14:35:06.058] Build status: SCHEDULED
[14:35:06.058] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:5:0) after 9m48s
[14:44:54.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:5:0)
[14:44:54.274] Build status: SCHEDULED
[14:44:54.275] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:6:0) after 7m36s
[14:52:30.396] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:6:0)
[14:52:30.453] Build status: SCHEDULED
[14:52:30.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:7:0) after 2m39s
[14:55:09.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:7:0)
[14:55:09.625] Build status: SCHEDULED
[14:55:09.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:8:0) after 3m16s
[14:58:25.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:8:0)
[14:58:25.716] Build status: SCHEDULED
[14:58:25.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:9:0) after 2m25s
[15:00:50.836] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:9:0)
[15:00:50.878] Build status: SCHEDULED
[15:00:50.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:10:0) after 1m56s
[15:02:46.972] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:10:0)
[15:02:46.993] Build status: SCHEDULED
[15:02:46.993] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:11:0) after 8m7s
[15:10:54.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:11:0)
[15:10:54.137] Build status: SCHEDULED
[15:10:54.137] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:12:0) after 8m31s
[15:19:25.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:12:0)
[15:19:25.183] Build status: SCHEDULED
[15:19:25.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:13:0) after 5m27s
[15:24:52.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:13:0)
[15:24:52.391] Build status: SCHEDULED
[15:24:52.391] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:14:0) after 4m57s
[15:29:49.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:14:0)
[15:29:49.811] Build status: SCHEDULED
[15:29:49.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:15:0) after 2m54s
[15:32:43.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:15:0)
[15:32:43.851] Build status: SCHEDULED
[15:32:43.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:16:0) after 1m0s
[15:33:43.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:16:0)
[15:33:43.891] Build status: SCHEDULED
[15:33:43.891] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:17:0) after 2m7s
[15:35:50.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:17:0)
[15:35:50.917] Build status: SCHEDULED
[15:35:50.917] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:18:0) after 9m51s
[15:45:41.984] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:18:0)
[15:45:42.001] Build status: SCHEDULED
[15:45:42.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:19:0) after 9m29s
[15:55:11.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:19:0)
[15:55:11.268] Build status: SCHEDULED
[15:55:11.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:20:0) after 4m19s
[15:59:30.313] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:20:0)
[15:59:30.339] Build status: SCHEDULED
[15:59:30.340] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:21:0) after 2m18s
[16:01:48.326] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:21:0)
[16:01:48.403] Build status: SCHEDULED
[16:01:48.403] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:22:0) after 2m30s
[16:04:18.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:22:0)
[16:04:18.447] Build status: SCHEDULED
[16:04:18.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:23:0) after 4m49s
[16:09:07.502] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:23:0)
[16:09:07.538] Build status: SCHEDULED
[16:09:07.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:24:0) after 4m25s
[16:13:32.603] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:24:0)
[16:13:32.623] Build status: SCHEDULED
[16:13:32.623] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:25:0) after 2m8s
[16:15:40.683] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:25:0)
[16:15:40.709] Build status: SCHEDULED
[16:15:40.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:26:0) after 6m22s
[16:22:02.733] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:26:0)
[16:22:02.754] Build status: SCHEDULED
[16:22:02.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:27:0) after 6m28s
[16:28:30.827] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:27:0)
[16:28:30.853] Build status: SCHEDULED
[16:28:30.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:28:0) after 9m39s
[16:38:09.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:28:0)
[16:38:09.958] Build status: SCHEDULED
[16:38:09.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:29:0) after 8m21s
[16:46:31.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:29:0)
[16:46:31.054] Build status: SCHEDULED
[16:46:31.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:30:0) after 8m25s
[16:54:56.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:30:0)
[16:54:56.049] Build status: SCHEDULED
[16:54:56.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:31:0) after 4m57s
[16:59:53.105] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:31:0)
[16:59:53.135] Build status: SCHEDULED
[16:59:53.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:32:0) after 3m41s
[17:03:34.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:32:0)
[17:03:34.184] Build status: SCHEDULED
[17:03:34.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:33:0) after 2m9s
[17:05:43.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:33:0)
[17:05:43.258] Build status: SCHEDULED
[17:05:43.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:34:0) after 6m3s
[17:11:46.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:34:0)
[17:11:46.315] Build status: SCHEDULED
[17:11:46.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:35:0) after 7m32s
[17:19:18.385] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:35:0)
[17:19:18.413] Build status: SCHEDULED
[17:19:18.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:36:0) after 3m44s
[17:23:02.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:36:0)
[17:23:02.464] Build status: SCHEDULED
[17:23:02.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:37:0) after 8m6s
[17:31:08.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:37:0)
[17:31:08.556] Build status: SCHEDULED
[17:31:08.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:38:0) after 7m36s
[17:38:44.576] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:38:0)
[17:38:44.598] Build status: SCHEDULED
[17:38:44.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:39:0) after 3m9s
[17:41:53.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:39:0)
[17:41:53.643] Build status: SCHEDULED
[17:41:53.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:40:0) after 5m25s
[17:47:18.667] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:40:0)
[17:47:18.717] Build status: SCHEDULED
[17:47:18.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:41:0) after 5m9s
[17:52:27.738] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:41:0)
[17:52:27.760] Build status: SCHEDULED
[17:52:27.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:42:0) after 9m25s
[17:56:14.203] Received PubSub notification, asking Buildbucket for the build status
[17:56:14.221] Build status: STARTED
[18:01:52.813] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:42:0)
[18:01:52.830] Build status: STARTED
[18:01:52.830] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:44:0) after 3m29s
[18:05:21.913] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:44:0)
[18:05:21.937] Build status: STARTED
[18:05:21.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:45:0) after 8m47s
[18:14:09.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:45:0)
[18:14:09.033] Build status: STARTED
[18:14:09.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:46:0) after 4m15s
[18:18:24.051] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:46:0)
[18:18:24.073] Build status: STARTED
[18:18:24.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:47:0) after 3m46s
[18:22:10.132] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:47:0)
[18:22:10.172] Build status: STARTED
[18:22:10.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:48:0) after 2m31s
[18:24:41.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:48:0)
[18:24:41.225] Build status: STARTED
[18:24:41.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:49:0) after 2m2s
[18:26:43.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:49:0)
[18:26:43.302] Build status: STARTED
[18:26:43.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:50:0) after 8m19s
[18:35:02.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:50:0)
[18:35:02.326] Build status: STARTED
[18:35:02.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:51:0) after 3m32s
[18:38:34.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:51:0)
[18:38:34.400] Build status: STARTED
[18:38:34.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:52:0) after 1m49s
[18:40:23.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:52:0)
[18:40:23.405] Build status: STARTED
[18:40:23.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:53:0) after 3m52s
[18:44:15.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:53:0)
[18:44:15.455] Build status: STARTED
[18:44:15.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:54:0) after 2m8s
[18:46:23.564] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:54:0)
[18:46:23.586] Build status: STARTED
[18:46:23.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:55:0) after 3m54s
[18:50:17.643] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:55:0)
[18:50:17.667] Build status: STARTED
[18:50:17.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:56:0) after 1m42s
[18:51:59.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:56:0)
[18:51:59.833] Build status: STARTED
[18:51:59.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:57:0) after 9m22s
[19:01:21.903] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:57:0)
[19:01:21.927] Build status: STARTED
[19:01:21.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:58:0) after 9m16s
[19:10:37.935] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:58:0)
[19:10:38.015] Build status: STARTED
[19:10:38.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:59:0) after 7m13s
[19:17:51.100] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:59:0)
[19:17:51.128] Build status: STARTED
[19:17:51.128] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:60:0) after 5m51s
[19:23:42.207] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:60:0)
[19:23:42.225] Build status: STARTED
[19:23:42.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:61:0) after 9m41s
[19:33:23.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:61:0)
[19:33:23.294] Build status: STARTED
[19:33:23.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:62:0) after 1m57s
[19:35:20.590] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:62:0)
[19:35:20.662] Build status: STARTED
[19:35:20.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:63:0) after 9m11s
[19:44:31.684] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:63:0)
[19:44:31.711] Build status: STARTED
[19:44:31.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:64:0) after 4m17s
[19:48:48.937] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:64:0)
[19:48:48.967] Build status: STARTED
[19:48:48.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:65:0) after 2m34s
[19:51:23.107] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:65:0)
[19:51:23.138] Build status: STARTED
[19:51:23.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:66:0) after 6m18s
[19:57:41.172] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:66:0)
[19:57:41.194] Build status: STARTED
[19:57:41.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:67:0) after 5m7s
[20:02:48.323] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:67:0)
[20:02:48.363] Build status: STARTED
[20:02:48.363] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:68:0) after 9m26s
[20:12:14.379] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:68:0)
[20:12:14.399] Build status: STARTED
[20:12:14.399] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:69:0) after 3m58s
[20:16:12.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:69:0)
[20:16:12.573] Build status: STARTED
[20:16:12.573] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:70:0) after 8m48s
[20:25:00.843] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:70:0)
[20:25:00.874] Build status: STARTED
[20:25:00.874] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:71:0) after 8m23s
[20:33:23.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:71:0)
[20:33:24.005] Build status: STARTED
[20:33:24.005] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:72:0) after 2m11s
[20:35:35.620] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:72:0)
[20:35:35.640] Build status: STARTED
[20:35:35.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:73:0) after 1m19s
[20:36:54.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:73:0)
[20:36:54.886] Build status: STARTED
[20:36:54.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:74:0) after 9m52s
[20:46:47.340] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:74:0)
[20:46:47.365] Build status: STARTED
[20:46:47.365] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:75:0) after 1m9s
[20:47:56.563] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:75:0)
[20:47:56.598] Build status: STARTED
[20:47:56.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:76:0) after 5m42s
[20:53:38.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:76:0)
[20:53:39.040] Build status: STARTED
[20:53:39.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8945547976359162496:77:0) after 8m12s
[21:00:37.693] Received PubSub notification, asking Buildbucket for the build status
[21:00:37.750] Build:
{
  "id": "8780117914299909297",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 3265,
  "createdBy": "project:r8",
  "createTime": "2023-05-25T14:14:32.321371464Z",
  "startTime": "2023-05-25T17:56:08.675265Z",
  "endTime": "2023-05-25T21:00:37.394725525Z",
  "updateTime": "2023-05-25T21:00:37.394725525Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "2d8c93fe249ac143a8ae9966e85ea1d387b897bc",
      "ref": "refs/heads/main"
    }
  }
}
[21:00:37.750] Invocation finished in 6h46m6.775911793s with status FAILED