[18:44:05.081] New invocation is queued and will start shortly
[18:44:06.286] Starting the invocation (attempt 1)
[18:44:06.317] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/40ed57c5054615d172f266dddb7b1ef5abf9b402"
[18:44:06.317] Popped gitiles commit info from properties and tags
[18:44:06.317] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:44:06.317] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:44:06.318] Buildbucket request:
{
"requestId": "8863268971095837088",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863268971095837088",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6d3971d97f362c02a0dd3f148b6e82f61810d025"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6d3971d97f362c02a0dd3f148b6e82f61810d025",
"title": "6d3971d97f362c02a0dd3f148b6e82f61810d025",
"url": "https://llvm.googlesource.com/llvm-project/+/6d3971d97f362c02a0dd3f148b6e82f61810d025"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58cffea94a31e52d6492ce7103e04c6b073dee16"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58cffea94a31e52d6492ce7103e04c6b073dee16",
"title": "58cffea94a31e52d6492ce7103e04c6b073dee16",
"url": "https://llvm.googlesource.com/llvm-project/+/58cffea94a31e52d6492ce7103e04c6b073dee16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b53371210fcf1f23d1f87e5727fdf1e9aefa674f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b53371210fcf1f23d1f87e5727fdf1e9aefa674f",
"title": "b53371210fcf1f23d1f87e5727fdf1e9aefa674f",
"url": "https://llvm.googlesource.com/llvm-project/+/b53371210fcf1f23d1f87e5727fdf1e9aefa674f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94e9bfb80365de0c9c71303418b33ceb767f7cf9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94e9bfb80365de0c9c71303418b33ceb767f7cf9",
"title": "94e9bfb80365de0c9c71303418b33ceb767f7cf9",
"url": "https://llvm.googlesource.com/llvm-project/+/94e9bfb80365de0c9c71303418b33ceb767f7cf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3cf1f0c127bcc11185a5f8f6a295ce678827b923"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3cf1f0c127bcc11185a5f8f6a295ce678827b923",
"title": "3cf1f0c127bcc11185a5f8f6a295ce678827b923",
"url": "https://llvm.googlesource.com/llvm-project/+/3cf1f0c127bcc11185a5f8f6a295ce678827b923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0b82415c59c57c40beb072a716675293e7007a65"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0b82415c59c57c40beb072a716675293e7007a65",
"title": "0b82415c59c57c40beb072a716675293e7007a65",
"url": "https://llvm.googlesource.com/llvm-project/+/0b82415c59c57c40beb072a716675293e7007a65"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c88ae6eb21201ee3c699a76ba424cbe42ae2e7b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c88ae6eb21201ee3c699a76ba424cbe42ae2e7b1",
"title": "c88ae6eb21201ee3c699a76ba424cbe42ae2e7b1",
"url": "https://llvm.googlesource.com/llvm-project/+/c88ae6eb21201ee3c699a76ba424cbe42ae2e7b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bd8c94177537ba30c6a160afa6dd1b8b8fc1e813"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bd8c94177537ba30c6a160afa6dd1b8b8fc1e813",
"title": "bd8c94177537ba30c6a160afa6dd1b8b8fc1e813",
"url": "https://llvm.googlesource.com/llvm-project/+/bd8c94177537ba30c6a160afa6dd1b8b8fc1e813"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d772663a9f003a08ee76414397963c58e80b27d7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d772663a9f003a08ee76414397963c58e80b27d7",
"title": "d772663a9f003a08ee76414397963c58e80b27d7",
"url": "https://llvm.googlesource.com/llvm-project/+/d772663a9f003a08ee76414397963c58e80b27d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5af03989cc01e7bf9a45240d86411e9eee5b0e8b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5af03989cc01e7bf9a45240d86411e9eee5b0e8b",
"title": "5af03989cc01e7bf9a45240d86411e9eee5b0e8b",
"url": "https://llvm.googlesource.com/llvm-project/+/5af03989cc01e7bf9a45240d86411e9eee5b0e8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5407e62611abfbb359f595d89d9f29adf647be02"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5407e62611abfbb359f595d89d9f29adf647be02",
"title": "5407e62611abfbb359f595d89d9f29adf647be02",
"url": "https://llvm.googlesource.com/llvm-project/+/5407e62611abfbb359f595d89d9f29adf647be02"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8bdd82ce1dd9c7da647b270b3a58eb36641e8e34"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8bdd82ce1dd9c7da647b270b3a58eb36641e8e34",
"title": "8bdd82ce1dd9c7da647b270b3a58eb36641e8e34",
"url": "https://llvm.googlesource.com/llvm-project/+/8bdd82ce1dd9c7da647b270b3a58eb36641e8e34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "40ed57c5054615d172f266dddb7b1ef5abf9b402"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@40ed57c5054615d172f266dddb7b1ef5abf9b402",
"title": "40ed57c5054615d172f266dddb7b1ef5abf9b402",
"url": "https://llvm.googlesource.com/llvm-project/+/40ed57c5054615d172f266dddb7b1ef5abf9b402"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "40ed57c5054615d172f266dddb7b1ef5abf9b402",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863268971095837088"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:44:06.708] Scheduled build:
{
"id": "8697838909063987425",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-18T18:44:06.394309445Z",
"updateTime": "2025-11-18T18:44:06.394309445Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "40ed57c5054615d172f266dddb7b1ef5abf9b402",
"ref": "refs/heads/main"
}
}
}
[18:44:06.708] Task URL: https://cr-buildbucket.appspot.com/build/8697838909063987425
[18:44:06.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:2:0) after 1m3s
[18:44:25.262] Received PubSub notification, asking Buildbucket for the build status
[18:44:25.283] Build status: STARTED
[18:44:33.047] Received PubSub notification, asking Buildbucket for the build status
[18:44:33.073] Build status: STARTED
[18:45:09.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:2:0)
[18:45:09.753] Build status: STARTED
[18:45:09.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:5:0) after 1m18s
[18:46:27.898] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:5:0)
[18:46:27.918] Build status: STARTED
[18:46:27.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:6:0) after 8m27s
[18:54:55.053] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:6:0)
[18:54:55.076] Build status: STARTED
[18:54:55.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:7:0) after 1m0s
[18:55:55.093] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:7:0)
[18:55:55.171] Build status: STARTED
[18:55:55.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:8:0) after 7m50s
[19:03:45.188] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:8:0)
[19:03:45.206] Build status: STARTED
[19:03:45.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:9:0) after 2m28s
[19:06:13.230] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:9:0)
[19:06:13.251] Build status: STARTED
[19:06:13.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:10:0) after 8m23s
[19:14:36.268] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:10:0)
[19:14:36.364] Build status: STARTED
[19:14:36.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:11:0) after 2m29s
[19:17:05.486] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:11:0)
[19:17:05.557] Build status: STARTED
[19:17:05.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:12:0) after 5m41s
[19:22:46.624] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:12:0)
[19:22:46.642] Build status: STARTED
[19:22:46.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:13:0) after 4m19s
[19:27:05.697] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:13:0)
[19:27:05.719] Build status: STARTED
[19:27:05.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:14:0) after 7m29s
[19:34:34.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:14:0)
[19:34:34.748] Build status: STARTED
[19:34:34.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:15:0) after 3m30s
[19:38:04.761] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:15:0)
[19:38:04.789] Build status: STARTED
[19:38:04.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:16:0) after 8m45s
[19:46:49.860] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:16:0)
[19:46:50.632] Build status: STARTED
[19:46:50.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:17:0) after 6m45s
[19:53:35.650] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:17:0)
[19:53:35.666] Build status: STARTED
[19:53:35.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:18:0) after 6m40s
[20:00:15.680] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:18:0)
[20:00:15.694] Build status: STARTED
[20:00:15.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:19:0) after 6m21s
[20:06:36.813] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:19:0)
[20:06:36.832] Build status: STARTED
[20:06:36.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:20:0) after 7m23s
[20:13:59.953] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:20:0)
[20:13:59.997] Build status: STARTED
[20:13:59.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8863268971095837088:21:0) after 7m52s
[20:14:43.179] Received PubSub notification, asking Buildbucket for the build status
[20:14:43.200] Build:
{
"id": "8697838909063987425",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-18T18:44:06.394309445Z",
"startTime": "2025-11-18T18:44:13.468969846Z",
"endTime": "2025-11-18T20:14:42.858832759Z",
"updateTime": "2025-11-18T20:14:42.858832759Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "40ed57c5054615d172f266dddb7b1ef5abf9b402",
"ref": "refs/heads/main"
}
}
}
[20:14:43.200] Invocation finished in 1h30m38.127065285s with status SUCCEEDED