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

• c84429efe23a6d8d38aeca82591f27cb7a32ea7e (6 days ago)
• 3c90b33f61f2266dee763d7ba4096c0c4c99ef1f (6 days ago)

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

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

[11:24:04.599] New invocation is queued and will start shortly
[11:24:05.844] Starting the invocation (attempt 1)
[11:24:05.867] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/3c90b33f61f2266dee763d7ba4096c0c4c99ef1f"
[11:24:05.867] Popped gitiles commit info from properties and tags
[11:24:05.867] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:24:05.867] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:24:05.868] Buildbucket request:
{
  "requestId": "8865199190297585984",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-dev"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8865199190297585984",
            "job": "r8/linux-dev",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "c84429efe23a6d8d38aeca82591f27cb7a32ea7e"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@c84429efe23a6d8d38aeca82591f27cb7a32ea7e",
                        "title": "c84429efe23a6d8d38aeca82591f27cb7a32ea7e",
                        "url": "https://r8.googlesource.com/r8/+/c84429efe23a6d8d38aeca82591f27cb7a32ea7e"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "3c90b33f61f2266dee763d7ba4096c0c4c99ef1f"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3c90b33f61f2266dee763d7ba4096c0c4c99ef1f",
                        "title": "3c90b33f61f2266dee763d7ba4096c0c4c99ef1f",
                        "url": "https://r8.googlesource.com/r8/+/3c90b33f61f2266dee763d7ba4096c0c4c99ef1f"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "3c90b33f61f2266dee763d7ba4096c0c4c99ef1f",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8865199190297585984"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/linux-dev"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[11:24:06.313] Scheduled build:
{
  "id": "8699769128258530513",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-dev"
  },
  "number": 1021,
  "createdBy": "project:r8",
  "createTime": "2025-10-28T11:24:05.923538930Z",
  "updateTime": "2025-10-28T11:24:05.923538930Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3c90b33f61f2266dee763d7ba4096c0c4c99ef1f",
      "ref": "refs/heads/main"
    }
  }
}
[11:24:06.313] Task URL: https://cr-buildbucket.appspot.com/build/8699769128258530513
[11:24:06.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:2:0) after 6m58s
[11:24:07.264] Received PubSub notification, asking Buildbucket for the build status
[11:24:07.348] Build status: SCHEDULED
[11:31:04.332] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:2:0)
[11:31:04.357] Build status: SCHEDULED
[11:31:04.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:4:0) after 6m47s
[11:37:51.372] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:4:0)
[11:37:51.411] Build status: SCHEDULED
[11:37:51.411] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:5:0) after 7m23s
[11:45:14.433] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:5:0)
[11:45:14.491] Build status: SCHEDULED
[11:45:14.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:6:0) after 3m38s
[11:48:53.038] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:6:0)
[11:48:53.053] Build status: SCHEDULED
[11:48:53.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:7:0) after 9m35s
[11:58:28.806] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:7:0)
[11:58:28.850] Build status: SCHEDULED
[11:58:28.850] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:8:0) after 6m17s
[12:04:45.882] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:8:0)
[12:04:45.911] Build status: SCHEDULED
[12:04:45.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:9:0) after 2m12s
[12:06:57.927] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:9:0)
[12:06:57.941] Build status: SCHEDULED
[12:06:57.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:10:0) after 7m54s
[12:14:52.005] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:10:0)
[12:14:52.026] Build status: SCHEDULED
[12:14:52.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:11:0) after 1m6s
[12:15:58.051] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:11:0)
[12:15:58.239] Build status: SCHEDULED
[12:15:58.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:12:0) after 2m28s
[12:18:26.284] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:12:0)
[12:18:26.301] Build status: SCHEDULED
[12:18:26.301] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:13:0) after 5m9s
[12:23:35.325] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:13:0)
[12:23:35.372] Build status: SCHEDULED
[12:23:35.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:14:0) after 4m48s
[12:28:23.434] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:14:0)
[12:28:23.453] Build status: SCHEDULED
[12:28:23.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:15:0) after 5m20s
[12:33:43.467] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:15:0)
[12:33:43.503] Build status: SCHEDULED
[12:33:43.503] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:16:0) after 7m39s
[12:41:22.565] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:16:0)
[12:41:22.591] Build status: SCHEDULED
[12:41:22.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:17:0) after 4m37s
[12:45:59.649] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:17:0)
[12:45:59.741] Build status: SCHEDULED
[12:45:59.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:18:0) after 4m37s
[12:50:36.893] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:18:0)
[12:50:36.911] Build status: SCHEDULED
[12:50:36.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:19:0) after 2m5s
[12:52:41.976] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:19:0)
[12:52:42.015] Build status: SCHEDULED
[12:52:42.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:20:0) after 9m34s
[13:02:16.029] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:20:0)
[13:02:16.050] Build status: SCHEDULED
[13:02:16.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:21:0) after 2m35s
[13:04:51.149] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:21:0)
[13:04:51.190] Build status: SCHEDULED
[13:04:51.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:22:0) after 1m1s
[13:05:52.210] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:22:0)
[13:05:52.226] Build status: SCHEDULED
[13:05:52.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:23:0) after 2m18s
[13:08:10.240] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:23:0)
[13:08:10.270] Build status: SCHEDULED
[13:08:10.270] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:24:0) after 2m20s
[13:10:30.444] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:24:0)
[13:10:30.461] Build status: SCHEDULED
[13:10:30.461] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:25:0) after 2m3s
[13:12:33.474] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:25:0)
[13:12:33.552] Build status: SCHEDULED
[13:12:33.552] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:26:0) after 8m14s
[13:18:10.271] Received PubSub notification, asking Buildbucket for the build status
[13:18:10.311] Build status: STARTED
[13:20:47.595] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:26:0)
[13:20:47.613] Build status: STARTED
[13:20:47.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:28:0) after 3m18s
[13:24:05.643] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:28:0)
[13:24:05.672] Build status: STARTED
[13:24:05.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:29:0) after 2m5s
[13:26:10.681] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:29:0)
[13:26:10.696] Build status: STARTED
[13:26:10.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:30:0) after 5m55s
[13:32:05.709] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:30:0)
[13:32:05.734] Build status: STARTED
[13:32:05.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:31:0) after 8m22s
[13:40:27.843] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:31:0)
[13:40:27.858] Build status: STARTED
[13:40:27.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:32:0) after 1m43s
[13:42:10.869] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:32:0)
[13:42:10.898] Build status: STARTED
[13:42:10.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:33:0) after 4m58s
[13:47:08.911] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:33:0)
[13:47:08.929] Build status: STARTED
[13:47:08.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:34:0) after 7m33s
[13:54:42.014] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:34:0)
[13:54:42.040] Build status: STARTED
[13:54:42.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:35:0) after 8m1s
[14:02:43.012] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:35:0)
[14:02:43.030] Build status: STARTED
[14:02:43.030] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:36:0) after 2m2s
[14:04:45.017] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:36:0)
[14:04:45.042] Build status: STARTED
[14:04:45.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:37:0) after 4m19s
[14:09:04.062] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:37:0)
[14:09:04.084] Build status: STARTED
[14:09:04.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:38:0) after 1m23s
[14:10:27.144] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:38:0)
[14:10:27.163] Build status: STARTED
[14:10:27.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:39:0) after 2m43s
[14:13:10.159] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:39:0)
[14:13:10.183] Build status: STARTED
[14:13:10.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:40:0) after 6m13s
[14:19:23.310] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:40:0)
[14:19:23.327] Build status: STARTED
[14:19:23.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:41:0) after 2m12s
[14:21:35.352] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:41:0)
[14:21:35.370] Build status: STARTED
[14:21:35.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:42:0) after 5m43s
[14:27:18.396] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:42:0)
[14:27:18.428] Build status: STARTED
[14:27:18.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:43:0) after 1m40s
[14:28:58.509] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:43:0)
[14:28:58.531] Build status: STARTED
[14:28:58.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:44:0) after 4m55s
[14:33:53.547] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:44:0)
[14:33:53.563] Build status: STARTED
[14:33:53.563] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:45:0) after 2m26s
[14:36:19.725] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:45:0)
[14:36:19.740] Build status: STARTED
[14:36:19.740] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:46:0) after 8m59s
[14:45:18.791] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:46:0)
[14:45:18.811] Build status: STARTED
[14:45:18.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:47:0) after 2m7s
[14:47:25.862] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:47:0)
[14:47:25.909] Build status: STARTED
[14:47:25.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:48:0) after 8m21s
[14:55:46.981] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:48:0)
[14:55:47.317] Build status: STARTED
[14:55:47.317] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:49:0) after 2m50s
[14:58:37.381] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:49:0)
[14:58:37.424] Build status: STARTED
[14:58:37.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:50:0) after 7m30s
[15:06:07.445] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:50:0)
[15:06:07.459] Build status: STARTED
[15:06:07.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:51:0) after 4m1s
[15:10:08.463] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:51:0)
[15:10:08.496] Build status: STARTED
[15:10:08.496] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:52:0) after 2m39s
[15:12:47.660] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:52:0)
[15:12:47.734] Build status: STARTED
[15:12:47.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:53:0) after 7m14s
[15:20:01.730] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:53:0)
[15:20:01.829] Build status: STARTED
[15:20:01.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:54:0) after 2m2s
[15:22:03.935] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:54:0)
[15:22:03.992] Build status: STARTED
[15:22:03.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:55:0) after 5m41s
[15:27:45.007] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:55:0)
[15:27:45.074] Build status: STARTED
[15:27:45.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:56:0) after 4m55s
[15:32:40.105] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:56:0)
[15:32:40.346] Build status: STARTED
[15:32:40.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:57:0) after 4m7s
[15:36:47.678] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:57:0)
[15:36:47.693] Build status: STARTED
[15:36:47.693] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:58:0) after 8m51s
[15:45:38.812] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:58:0)
[15:45:38.851] Build status: STARTED
[15:45:38.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:59:0) after 8m34s
[15:54:12.870] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:59:0)
[15:54:12.895] Build status: STARTED
[15:54:12.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:60:0) after 2m35s
[15:56:47.964] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:60:0)
[15:56:47.992] Build status: STARTED
[15:56:47.993] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:61:0) after 2m40s
[15:59:28.050] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:61:0)
[15:59:28.077] Build status: STARTED
[15:59:28.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:62:0) after 7m35s
[16:07:03.062] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:62:0)
[16:07:03.081] Build status: STARTED
[16:07:03.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:63:0) after 9m25s
[16:16:28.115] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:63:0)
[16:16:28.201] Build status: STARTED
[16:16:28.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:64:0) after 6m43s
[16:23:11.271] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:64:0)
[16:23:11.324] Build status: STARTED
[16:23:11.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:65:0) after 4m34s
[16:27:45.491] Handling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:65:0)
[16:27:45.507] Build status: STARTED
[16:27:45.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-dev:8865199190297585984:66:0) after 1m39s
[16:28:53.384] Received PubSub notification, asking Buildbucket for the build status
[16:28:53.405] Build:
{
  "id": "8699769128258530513",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-dev"
  },
  "number": 1021,
  "createdBy": "project:r8",
  "createTime": "2025-10-28T11:24:05.923538930Z",
  "startTime": "2025-10-28T13:18:09.839986074Z",
  "endTime": "2025-10-28T16:28:53.063675213Z",
  "updateTime": "2025-10-28T16:28:53.063675213Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3c90b33f61f2266dee763d7ba4096c0c4c99ef1f",
      "ref": "refs/heads/main"
    }
  }
}
[16:28:53.405] Invocation finished in 5h4m48.810093273s with status FAILED