[01:12:32.627] New invocation is queued and will start shortly
[01:12:32.627] Triggered by user:clang-prod-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[01:12:33.876] Starting the invocation (attempt 1)
[01:12:33.905] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c745f745b11766949cfc7326e69e3cdccf9cc893"
[01:12:33.906] Reconstructed gitiles commit from tags
[01:12:33.906] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:12:33.906] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:12:33.906] Buildbucket request:
{
  "requestId": "8865600052491943504",
  "builder": {
    "project": "pigweed",
    "bucket": "pigweed.toolchain",
    "builder": "toolchain-prod-pigweed-mac-x86"
  },
  "properties": {
      "$fuchsia/checkout": {
            "clang_toolchain": {
                  "cas_digest": "9349cf10e4124571cc48893a6acc3024cdccd0e12fc0dd8282326d2d23eadeb4/578",
                  "cas_instance": "projects/chromium-swarm/instances/default_instance"
                },
            "gitiles_commit": {
                  "host": "fuchsia.googlesource.com",
                  "id": "b95ebfd204d4d1da368d1fd0aaacbbddc1f41024",
                  "project": "integration",
                  "ref": "refs/heads/releases/canary"
                }
          },
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8865600052491943504",
            "job": "pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86",
            "triggers": [
                  {
                        "buildbucket": {
                              "properties": {
                                    "$fuchsia/checkout": {
                                          "clang_toolchain": {
                                                "cas_digest": "9349cf10e4124571cc48893a6acc3024cdccd0e12fc0dd8282326d2d23eadeb4/578",
                                                "cas_instance": "projects/chromium-swarm/instances/default_instance"
                                              },
                                          "gitiles_commit": {
                                                "host": "fuchsia.googlesource.com",
                                                "id": "b95ebfd204d4d1da368d1fd0aaacbbddc1f41024",
                                                "project": "integration",
                                                "ref": "refs/heads/releases/canary"
                                              }
                                        },
                                    "clang_toolchain": {
                                          "git_repository": "https://llvm.googlesource.com/llvm-project",
                                          "git_revision": "c745f745b11766949cfc7326e69e3cdccf9cc893"
                                        }
                                  },
                              "tags": [
                                    "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c745f745b11766949cfc7326e69e3cdccf9cc893",
                                    "gitiles_ref:refs/heads/main",
                                    "parent_buildername:clang-mac-x64",
                                    "user_agent:recipe"
                                  ]
                            },
                        "id": "94728ce7-6ab0-4f3d-bdb6-3f4be6443ba0",
                        "title": "clang-mac-x64/0",
                        "url": "https://cr-buildbucket.appspot.com/build/8700181298425943857"
                      }
                ]
          },
      "clang_toolchain": {
            "git_repository": "https://llvm.googlesource.com/llvm-project",
            "git_revision": "c745f745b11766949cfc7326e69e3cdccf9cc893"
          }
    },
  "gitilesCommit": {
    "host": "llvm.googlesource.com",
    "project": "llvm-project",
    "id": "c745f745b11766949cfc7326e69e3cdccf9cc893",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8865600052491943504"
    },
    {
      "key": "scheduler_job_id",
      "value": "pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    },
    {
      "key": "parent_buildername",
      "value": "clang-mac-x64"
    },
    {
      "key": "user_agent",
      "value": "recipe"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[01:12:34.383] Scheduled build:
{
  "id": "8700169990413293585",
  "builder": {
    "project": "pigweed",
    "bucket": "pigweed.toolchain",
    "builder": "toolchain-prod-pigweed-mac-x86"
  },
  "createdBy": "project:pigweed",
  "createTime": "2025-10-24T01:12:33.982647688Z",
  "updateTime": "2025-10-24T01:12:33.982647688Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "c745f745b11766949cfc7326e69e3cdccf9cc893",
      "ref": "refs/heads/main"
    }
  }
}
[01:12:34.383] Task URL: https://cr-buildbucket.appspot.com/build/8700169990413293585
[01:12:34.383] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:2:0) after 6m45s
[01:12:35.451] Received PubSub notification, asking Buildbucket for the build status
[01:12:35.464] Build status: SCHEDULED
[01:19:19.396] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:2:0)
[01:19:19.413] Build status: SCHEDULED
[01:19:19.413] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:4:0) after 9m10s
[01:28:29.468] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:4:0)
[01:28:29.500] Build status: SCHEDULED
[01:28:29.500] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:5:0) after 5m42s
[01:34:11.552] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:5:0)
[01:34:11.569] Build status: SCHEDULED
[01:34:11.569] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:6:0) after 4m37s
[01:38:48.582] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:6:0)
[01:38:48.607] Build status: SCHEDULED
[01:38:48.607] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:7:0) after 3m52s
[01:42:40.721] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:7:0)
[01:42:40.743] Build status: SCHEDULED
[01:42:40.743] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:8:0) after 9m16s
[01:51:56.768] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:8:0)
[01:51:56.787] Build status: SCHEDULED
[01:51:56.787] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:9:0) after 5m1s
[01:56:57.798] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:9:0)
[01:56:57.815] Build status: SCHEDULED
[01:56:57.816] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:10:0) after 8m37s
[02:05:34.797] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:10:0)
[02:05:34.819] Build status: SCHEDULED
[02:05:34.819] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:11:0) after 4m48s
[02:10:22.832] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:11:0)
[02:10:22.849] Build status: SCHEDULED
[02:10:22.849] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:12:0) after 1m44s
[02:12:06.866] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:12:0)
[02:12:06.925] Build status: SCHEDULED
[02:12:06.925] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:13:0) after 8m13s
[02:20:20.073] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:13:0)
[02:20:20.109] Build status: SCHEDULED
[02:20:20.109] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:14:0) after 1m18s
[02:21:38.122] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:14:0)
[02:21:38.138] Build status: SCHEDULED
[02:21:38.138] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:15:0) after 8m49s
[02:30:27.151] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:15:0)
[02:30:27.180] Build status: SCHEDULED
[02:30:27.180] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:16:0) after 4m57s
[02:35:24.222] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:16:0)
[02:35:24.290] Build status: SCHEDULED
[02:35:24.290] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:17:0) after 8m57s
[02:43:19.127] Received PubSub notification, asking Buildbucket for the build status
[02:43:19.159] Build status: STARTED
[02:44:21.303] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:17:0)
[02:44:21.321] Build status: STARTED
[02:44:21.321] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:19:0) after 8m24s
[02:52:45.363] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:19:0)
[02:52:45.384] Build status: STARTED
[02:52:45.384] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:20:0) after 3m52s
[02:56:37.633] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:20:0)
[02:56:37.753] Build status: STARTED
[02:56:37.753] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:21:0) after 7m50s
[03:04:27.789] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:21:0)
[03:04:27.812] Build status: STARTED
[03:04:27.812] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:22:0) after 6m33s
[03:11:00.828] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:22:0)
[03:11:00.855] Build status: STARTED
[03:11:00.855] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:23:0) after 8m34s
[03:19:34.914] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:23:0)
[03:19:34.935] Build status: STARTED
[03:19:34.935] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:24:0) after 7m21s
[03:26:55.951] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:24:0)
[03:26:55.967] Build status: STARTED
[03:26:55.967] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:25:0) after 5m15s
[03:32:11.178] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:25:0)
[03:32:11.217] Build status: STARTED
[03:32:11.217] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:26:0) after 9m45s
[03:41:56.283] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:26:0)
[03:41:56.300] Build status: STARTED
[03:41:56.301] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:27:0) after 9m27s
[03:51:23.267] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:27:0)
[03:51:23.290] Build status: STARTED
[03:51:23.290] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.toolchain-toolchain-prod-pigweed-mac-x86:8865600052491943504:28:0) after 5m59s
[03:54:19.895] Received PubSub notification, asking Buildbucket for the build status
[03:54:19.910] Build:
{
  "id": "8700169990413293585",
  "builder": {
    "project": "pigweed",
    "bucket": "pigweed.toolchain",
    "builder": "toolchain-prod-pigweed-mac-x86"
  },
  "createdBy": "project:pigweed",
  "createTime": "2025-10-24T01:12:33.982647688Z",
  "startTime": "2025-10-24T02:43:11.805420541Z",
  "endTime": "2025-10-24T03:54:19.596508269Z",
  "updateTime": "2025-10-24T03:54:19.596508269Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "llvm.googlesource.com",
      "project": "llvm-project",
      "id": "c745f745b11766949cfc7326e69e3cdccf9cc893",
      "ref": "refs/heads/main"
    }
  }
}
[03:54:19.910] Invocation finished in 2h41m47.293978008s with status SUCCEEDED