[07:54:19.084] New invocation is queued and will start shortly
[07:54:20.166] Starting the invocation (attempt 1)
[07:54:20.193] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2b46f31ee332b7ff3d22b4fffdba12e231b3f796"
[07:54:20.193] Popped gitiles commit info from properties and tags
[07:54:20.193] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:54:20.193] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:54:20.193] Buildbucket request:
{
  "requestId": "8871282383916584992",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8871282383916584992",
            "job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "5050da7ba18fc876f80fbeaaca3564d3b4483bb8"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5050da7ba18fc876f80fbeaaca3564d3b4483bb8",
                        "title": "5050da7ba18fc876f80fbeaaca3564d3b4483bb8",
                        "url": "https://llvm.googlesource.com/llvm-project/+/5050da7ba18fc876f80fbeaaca3564d3b4483bb8"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "36dc6146b8f35ebf38384896e80e8fcabbddfb54"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@36dc6146b8f35ebf38384896e80e8fcabbddfb54",
                        "title": "36dc6146b8f35ebf38384896e80e8fcabbddfb54",
                        "url": "https://llvm.googlesource.com/llvm-project/+/36dc6146b8f35ebf38384896e80e8fcabbddfb54"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "06ab660911eef084716fdc6f13595cdbff9da08a"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@06ab660911eef084716fdc6f13595cdbff9da08a",
                        "title": "06ab660911eef084716fdc6f13595cdbff9da08a",
                        "url": "https://llvm.googlesource.com/llvm-project/+/06ab660911eef084716fdc6f13595cdbff9da08a"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "945a186089f7c98a184f5e12c3723dca4db4b6ce"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@945a186089f7c98a184f5e12c3723dca4db4b6ce",
                        "title": "945a186089f7c98a184f5e12c3723dca4db4b6ce",
                        "url": "https://llvm.googlesource.com/llvm-project/+/945a186089f7c98a184f5e12c3723dca4db4b6ce"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "50f7c6a5b94ea312d789511517b0800a0dab1230"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50f7c6a5b94ea312d789511517b0800a0dab1230",
                        "title": "50f7c6a5b94ea312d789511517b0800a0dab1230",
                        "url": "https://llvm.googlesource.com/llvm-project/+/50f7c6a5b94ea312d789511517b0800a0dab1230"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "cf5243619ab2d48e3e533c691fc80c49c2f9645f"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf5243619ab2d48e3e533c691fc80c49c2f9645f",
                        "title": "cf5243619ab2d48e3e533c691fc80c49c2f9645f",
                        "url": "https://llvm.googlesource.com/llvm-project/+/cf5243619ab2d48e3e533c691fc80c49c2f9645f"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "e0945dfa309080b0a670dc9facaec69c8bc58f51"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0945dfa309080b0a670dc9facaec69c8bc58f51",
                        "title": "e0945dfa309080b0a670dc9facaec69c8bc58f51",
                        "url": "https://llvm.googlesource.com/llvm-project/+/e0945dfa309080b0a670dc9facaec69c8bc58f51"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "2b46f31ee332b7ff3d22b4fffdba12e231b3f796"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b46f31ee332b7ff3d22b4fffdba12e231b3f796",
                        "title": "2b46f31ee332b7ff3d22b4fffdba12e231b3f796",
                        "url": "https://llvm.googlesource.com/llvm-project/+/2b46f31ee332b7ff3d22b4fffdba12e231b3f796"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "llvm.googlesource.com",
    "project": "llvm-project",
    "id": "2b46f31ee332b7ff3d22b4fffdba12e231b3f796",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8871282383916584992"
    },
    {
      "key": "scheduler_job_id",
      "value": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[07:54:20.610] Scheduled build:
{
  "id": "8705852322018172625",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-08-22T07:54:20.273197168Z",
  "updateTime": "2025-08-22T07:54:20.273197168Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "2b46f31ee332b7ff3d22b4fffdba12e231b3f796",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[07:54:20.610] Task URL: https://cr-buildbucket.appspot.com/build/8705852322018172625
[07:54:20.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:2:0) after 2m16s
[07:54:21.617] Received PubSub notification, asking Buildbucket for the build status
[07:54:21.636] Build status: SCHEDULED
[07:54:32.057] Received PubSub notification, asking Buildbucket for the build status
[07:54:32.084] Build status: STARTED
[07:56:37.229] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:2:0)
[07:56:37.344] Build status: STARTED
[07:56:37.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:5:0) after 5m0s
[08:01:37.394] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:5:0)
[08:01:37.413] Build status: STARTED
[08:01:37.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:6:0) after 5m50s
[08:07:27.482] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:6:0)
[08:07:27.502] Build status: STARTED
[08:07:27.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:7:0) after 2m17s
[08:09:44.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:7:0)
[08:09:44.754] Build status: STARTED
[08:09:44.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:8:0) after 9m3s
[08:18:47.766] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:8:0)
[08:18:47.799] Build status: STARTED
[08:18:47.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:9:0) after 4m19s
[08:23:07.141] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:9:0)
[08:23:07.160] Build status: STARTED
[08:23:07.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:10:0) after 2m33s
[08:25:40.175] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:10:0)
[08:25:40.340] Build status: STARTED
[08:25:40.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871282383916584992:11:0) after 3m36s
[08:26:21.967] Received PubSub notification, asking Buildbucket for the build status
[08:26:21.990] Build:
{
  "id": "8705852322018172625",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-08-22T07:54:20.273197168Z",
  "startTime": "2025-08-22T07:54:31.833642722Z",
  "endTime": "2025-08-22T08:26:21.573108569Z",
  "updateTime": "2025-08-22T08:26:21.573108569Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "2b46f31ee332b7ff3d22b4fffdba12e231b3f796",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[08:26:21.990] Invocation finished in 32m2.911548022s with status FAILED