[15:18:16.117] New invocation is queued and will start shortly
[15:18:17.155] Starting the invocation (attempt 1)
[15:18:17.197] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d23b3a58dd159612dd7ebb0692771545c277f248"
[15:18:17.197] Popped gitiles commit info from properties and tags
[15:18:17.197] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:18:17.197] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:18:17.197] Buildbucket request:
{
"requestId": "8857393117114480128",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857393117114480128",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a37eacbf56c8022ad716f2e1b17497bd6ae3602"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a37eacbf56c8022ad716f2e1b17497bd6ae3602",
"title": "7a37eacbf56c8022ad716f2e1b17497bd6ae3602",
"url": "https://llvm.googlesource.com/llvm-project/+/7a37eacbf56c8022ad716f2e1b17497bd6ae3602"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "580176741d990d14f65db81574aaa8954b76b793"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@580176741d990d14f65db81574aaa8954b76b793",
"title": "580176741d990d14f65db81574aaa8954b76b793",
"url": "https://llvm.googlesource.com/llvm-project/+/580176741d990d14f65db81574aaa8954b76b793"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b4b9ed6ad16f7ecdf947b92b8ee250d6d0cf7636"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b4b9ed6ad16f7ecdf947b92b8ee250d6d0cf7636",
"title": "b4b9ed6ad16f7ecdf947b92b8ee250d6d0cf7636",
"url": "https://llvm.googlesource.com/llvm-project/+/b4b9ed6ad16f7ecdf947b92b8ee250d6d0cf7636"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "986be54564add8e8fd0dade557d663a87661deb9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@986be54564add8e8fd0dade557d663a87661deb9",
"title": "986be54564add8e8fd0dade557d663a87661deb9",
"url": "https://llvm.googlesource.com/llvm-project/+/986be54564add8e8fd0dade557d663a87661deb9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d23b3a58dd159612dd7ebb0692771545c277f248"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d23b3a58dd159612dd7ebb0692771545c277f248",
"title": "d23b3a58dd159612dd7ebb0692771545c277f248",
"url": "https://llvm.googlesource.com/llvm-project/+/d23b3a58dd159612dd7ebb0692771545c277f248"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d23b3a58dd159612dd7ebb0692771545c277f248",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857393117114480128"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:18:17.578] Scheduled build:
{
"id": "8691963055253011713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-22T15:18:17.261080735Z",
"updateTime": "2026-01-22T15:18:17.261080735Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d23b3a58dd159612dd7ebb0692771545c277f248",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:18:17.578] Task URL: https://cr-buildbucket.appspot.com/build/8691963055253011713
[15:18:17.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:2:0) after 9m25s
[15:18:17.893] Received PubSub notification, asking Buildbucket for the build status
[15:18:17.908] Build status: SCHEDULED
[15:18:23.756] Received PubSub notification, asking Buildbucket for the build status
[15:18:23.770] Build status: STARTED
[15:27:42.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:2:0)
[15:27:42.685] Build status: STARTED
[15:27:42.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:5:0) after 3m20s
[15:31:02.697] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:5:0)
[15:31:02.724] Build status: STARTED
[15:31:02.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:6:0) after 9m46s
[15:40:48.763] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:6:0)
[15:40:48.790] Build status: STARTED
[15:40:48.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:7:0) after 1m46s
[15:42:34.903] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:7:0)
[15:42:34.919] Build status: STARTED
[15:42:34.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:8:0) after 1m31s
[15:44:06.052] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:8:0)
[15:44:06.076] Build status: STARTED
[15:44:06.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:9:0) after 8m2s
[15:52:08.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:9:0)
[15:52:08.130] Build status: STARTED
[15:52:08.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:10:0) after 9m31s
[16:01:39.217] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:10:0)
[16:01:39.248] Build status: STARTED
[16:01:39.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8857393117114480128:11:0) after 8m56s
[16:09:02.771] Received PubSub notification, asking Buildbucket for the build status
[16:09:02.787] Build:
{
"id": "8691963055253011713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-22T15:18:17.261080735Z",
"startTime": "2026-01-22T15:18:22.590382709Z",
"endTime": "2026-01-22T16:09:02.488347125Z",
"updateTime": "2026-01-22T16:09:02.488347125Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d23b3a58dd159612dd7ebb0692771545c277f248",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:09:02.787] Invocation finished in 50m46.685051091s with status SUCCEEDED