[21:18:33.182] New invocation is queued and will start shortly
[21:18:34.288] Starting the invocation (attempt 1)
[21:18:34.319] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748"
[21:18:34.319] Popped gitiles commit info from properties and tags
[21:18:34.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:18:34.319] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:18:34.319] Buildbucket request:
{
"requestId": "8852750004683942064",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8852750004683942064",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e3baec4bfb6f069031963fcfe87353a265d1bc20"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e3baec4bfb6f069031963fcfe87353a265d1bc20",
"title": "e3baec4bfb6f069031963fcfe87353a265d1bc20",
"url": "https://llvm.googlesource.com/llvm-project/+/e3baec4bfb6f069031963fcfe87353a265d1bc20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e3d2b6fbce0ad132a60bb38dace9722f37db314"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e3d2b6fbce0ad132a60bb38dace9722f37db314",
"title": "3e3d2b6fbce0ad132a60bb38dace9722f37db314",
"url": "https://llvm.googlesource.com/llvm-project/+/3e3d2b6fbce0ad132a60bb38dace9722f37db314"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6af0466e7733e723607f31bd3186231d03183670"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6af0466e7733e723607f31bd3186231d03183670",
"title": "6af0466e7733e723607f31bd3186231d03183670",
"url": "https://llvm.googlesource.com/llvm-project/+/6af0466e7733e723607f31bd3186231d03183670"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74af9c3252cb1d04ddc32273f8f16fdc53a39de1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74af9c3252cb1d04ddc32273f8f16fdc53a39de1",
"title": "74af9c3252cb1d04ddc32273f8f16fdc53a39de1",
"url": "https://llvm.googlesource.com/llvm-project/+/74af9c3252cb1d04ddc32273f8f16fdc53a39de1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b85e7f04397752926175d72b953fa428f08c656a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b85e7f04397752926175d72b953fa428f08c656a",
"title": "b85e7f04397752926175d72b953fa428f08c656a",
"url": "https://llvm.googlesource.com/llvm-project/+/b85e7f04397752926175d72b953fa428f08c656a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5cc4594154d96730ecbf34968779a28b1ab757ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5cc4594154d96730ecbf34968779a28b1ab757ab",
"title": "5cc4594154d96730ecbf34968779a28b1ab757ab",
"url": "https://llvm.googlesource.com/llvm-project/+/5cc4594154d96730ecbf34968779a28b1ab757ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d700dea8d69f296f958a38f521e0bb1b7512c202"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d700dea8d69f296f958a38f521e0bb1b7512c202",
"title": "d700dea8d69f296f958a38f521e0bb1b7512c202",
"url": "https://llvm.googlesource.com/llvm-project/+/d700dea8d69f296f958a38f521e0bb1b7512c202"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748",
"title": "9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748",
"url": "https://llvm.googlesource.com/llvm-project/+/9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8852750004683942064"
},
{
"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"
}
}
[21:18:34.759] Scheduled build:
{
"id": "8687319942730386129",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-14T21:18:34.422418390Z",
"updateTime": "2026-03-14T21:18:34.422418390Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748",
"ref": "refs/heads/main"
}
}
}
[21:18:34.759] Task URL: https://cr-buildbucket.appspot.com/build/8687319942730386129
[21:18:34.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:2:0) after 7m36s
[21:18:35.799] Received PubSub notification, asking Buildbucket for the build status
[21:18:35.891] Build status: SCHEDULED
[21:19:27.441] Received PubSub notification, asking Buildbucket for the build status
[21:19:27.456] Build status: STARTED
[21:26:10.780] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:2:0)
[21:26:10.798] Build status: STARTED
[21:26:10.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:5:0) after 7m44s
[21:33:55.153] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:5:0)
[21:33:55.170] Build status: STARTED
[21:33:55.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:6:0) after 8m29s
[21:42:24.555] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:6:0)
[21:42:24.575] Build status: STARTED
[21:42:24.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:7:0) after 1m37s
[21:44:01.590] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:7:0)
[21:44:01.622] Build status: STARTED
[21:44:01.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:8:0) after 9m5s
[21:53:06.658] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:8:0)
[21:53:06.673] Build status: STARTED
[21:53:06.673] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:9:0) after 5m20s
[21:58:26.689] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:9:0)
[21:58:26.709] Build status: STARTED
[21:58:26.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:10:0) after 9m48s
[22:08:15.095] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:10:0)
[22:08:15.120] Build status: STARTED
[22:08:15.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:11:0) after 9m59s
[22:18:14.158] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:11:0)
[22:18:14.277] Build status: STARTED
[22:18:14.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:12:0) after 7m43s
[22:25:57.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:12:0)
[22:25:57.444] Build status: STARTED
[22:25:57.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:13:0) after 4m6s
[22:30:03.468] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:13:0)
[22:30:03.485] Build status: STARTED
[22:30:03.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:14:0) after 9m43s
[22:39:46.964] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:14:0)
[22:39:46.982] Build status: STARTED
[22:39:46.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:15:0) after 7m27s
[22:47:13.964] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:15:0)
[22:47:13.996] Build status: STARTED
[22:47:13.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8852750004683942064:16:0) after 5m22s
[22:52:06.646] Received PubSub notification, asking Buildbucket for the build status
[22:52:06.696] Build:
{
"id": "8687319942730386129",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-14T21:18:34.422418390Z",
"startTime": "2026-03-14T21:19:26.719064771Z",
"endTime": "2026-03-14T22:52:06.097369595Z",
"updateTime": "2026-03-14T22:52:06.097369595Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9de31c4a3e77ceb1e736d4df3ae9e3f5a1dc8748",
"ref": "refs/heads/main"
}
}
}
[22:52:06.696] Invocation finished in 1h33m33.521143738s with status SUCCEEDED