[10:04:52.830] New invocation is queued and will start shortly
[10:04:54.186] Starting the invocation (attempt 1)
[10:04:54.217] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/843977713129614db1b07ce877f59de133c8288e"
[10:04:54.217] Popped gitiles commit info from properties and tags
[10:04:54.217] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:04:54.217] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:04:54.217] Buildbucket request:
{
  "requestId": "8871274169637479536",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8871274169637479536",
            "job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "bfc16510c73be15ba4468264dfc4c8e98dff1df9"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bfc16510c73be15ba4468264dfc4c8e98dff1df9",
                        "title": "bfc16510c73be15ba4468264dfc4c8e98dff1df9",
                        "url": "https://llvm.googlesource.com/llvm-project/+/bfc16510c73be15ba4468264dfc4c8e98dff1df9"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "7594b4b8d1bca197282d185e6c309cd71fcce380"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7594b4b8d1bca197282d185e6c309cd71fcce380",
                        "title": "7594b4b8d1bca197282d185e6c309cd71fcce380",
                        "url": "https://llvm.googlesource.com/llvm-project/+/7594b4b8d1bca197282d185e6c309cd71fcce380"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "fda24dbc16abc414bf21b74e77d3acd2ecadfdb9"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fda24dbc16abc414bf21b74e77d3acd2ecadfdb9",
                        "title": "fda24dbc16abc414bf21b74e77d3acd2ecadfdb9",
                        "url": "https://llvm.googlesource.com/llvm-project/+/fda24dbc16abc414bf21b74e77d3acd2ecadfdb9"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://llvm.googlesource.com/llvm-project",
                              "revision": "843977713129614db1b07ce877f59de133c8288e"
                            },
                        "id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@843977713129614db1b07ce877f59de133c8288e",
                        "title": "843977713129614db1b07ce877f59de133c8288e",
                        "url": "https://llvm.googlesource.com/llvm-project/+/843977713129614db1b07ce877f59de133c8288e"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "llvm.googlesource.com",
    "project": "llvm-project",
    "id": "843977713129614db1b07ce877f59de133c8288e",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8871274169637479536"
    },
    {
      "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"
  }
}
[10:04:54.630] Scheduled build:
{
  "id": "8705844107469665681",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-08-22T10:04:54.277994586Z",
  "updateTime": "2025-08-22T10:04:54.277994586Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "843977713129614db1b07ce877f59de133c8288e",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[10:04:54.630] Task URL: https://cr-buildbucket.appspot.com/build/8705844107469665681
[10:04:54.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:2:0) after 7m1s
[10:04:54.734] Received PubSub notification, asking Buildbucket for the build status
[10:04:54.760] Build status: SCHEDULED
[10:04:57.909] Received PubSub notification, asking Buildbucket for the build status
[10:04:57.929] Build status: STARTED
[10:11:55.789] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:2:0)
[10:11:55.818] Build status: STARTED
[10:11:55.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:5:0) after 9m23s
[10:21:18.890] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:5:0)
[10:21:18.962] Build status: STARTED
[10:21:18.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:6:0) after 1m37s
[10:22:56.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:6:0)
[10:22:56.218] Build status: STARTED
[10:22:56.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:7:0) after 9m47s
[10:32:43.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:7:0)
[10:32:43.365] Build status: STARTED
[10:32:43.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8871274169637479536:8:0) after 9m22s
[10:39:12.753] Received PubSub notification, asking Buildbucket for the build status
[10:39:12.879] Build:
{
  "id": "8705844107469665681",
  "builder": {
    "project": "fuchsia",
    "bucket": "toolchain.ci",
    "builder": "clang-windows-x64"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-08-22T10:04:54.277994586Z",
  "startTime": "2025-08-22T10:04:57.591815393Z",
  "endTime": "2025-08-22T10:39:12.487104037Z",
  "updateTime": "2025-08-22T10:39:12.487104037Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "843977713129614db1b07ce877f59de133c8288e",
      "ref": "refs/heads/main"
    }
  },
  "canary": true
}
[10:39:12.879] Invocation finished in 34m20.052965351s with status FAILED