[12:40:11.600] New invocation is queued and will start shortly
[12:40:12.677] Starting the invocation (attempt 1)
[12:40:12.701] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3200d64c33de2ae3bba136c6ea3b80cdad3a30f8"
[12:40:12.701] Popped gitiles commit info from properties and tags
[12:40:12.701] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:40:12.701] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:40:12.701] Buildbucket request:
{
"requestId": "8851061274700742320",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851061274700742320",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "64b728128df355b9838eb7f6c19082628fb30dbe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@64b728128df355b9838eb7f6c19082628fb30dbe",
"title": "64b728128df355b9838eb7f6c19082628fb30dbe",
"url": "https://llvm.googlesource.com/llvm-project/+/64b728128df355b9838eb7f6c19082628fb30dbe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "72e8c9b78f01439d34cbd05ed8d269a2758834de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@72e8c9b78f01439d34cbd05ed8d269a2758834de",
"title": "72e8c9b78f01439d34cbd05ed8d269a2758834de",
"url": "https://llvm.googlesource.com/llvm-project/+/72e8c9b78f01439d34cbd05ed8d269a2758834de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c4b0f9959abe998f4985c1ef4ccfa22dc9096864"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c4b0f9959abe998f4985c1ef4ccfa22dc9096864",
"title": "c4b0f9959abe998f4985c1ef4ccfa22dc9096864",
"url": "https://llvm.googlesource.com/llvm-project/+/c4b0f9959abe998f4985c1ef4ccfa22dc9096864"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "803d1d66094c9d2e543f5e62a426ef972e100a93"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@803d1d66094c9d2e543f5e62a426ef972e100a93",
"title": "803d1d66094c9d2e543f5e62a426ef972e100a93",
"url": "https://llvm.googlesource.com/llvm-project/+/803d1d66094c9d2e543f5e62a426ef972e100a93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7410a81fbd72e0eb525d7b09ef2cbfa55ee4f973"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7410a81fbd72e0eb525d7b09ef2cbfa55ee4f973",
"title": "7410a81fbd72e0eb525d7b09ef2cbfa55ee4f973",
"url": "https://llvm.googlesource.com/llvm-project/+/7410a81fbd72e0eb525d7b09ef2cbfa55ee4f973"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eaa3ef9ddc20edbe6a99be7ea53d0d2ea0585f77"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eaa3ef9ddc20edbe6a99be7ea53d0d2ea0585f77",
"title": "eaa3ef9ddc20edbe6a99be7ea53d0d2ea0585f77",
"url": "https://llvm.googlesource.com/llvm-project/+/eaa3ef9ddc20edbe6a99be7ea53d0d2ea0585f77"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "329af7d2b785e0c7032427fdd11881f8c7280a52"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@329af7d2b785e0c7032427fdd11881f8c7280a52",
"title": "329af7d2b785e0c7032427fdd11881f8c7280a52",
"url": "https://llvm.googlesource.com/llvm-project/+/329af7d2b785e0c7032427fdd11881f8c7280a52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3200d64c33de2ae3bba136c6ea3b80cdad3a30f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3200d64c33de2ae3bba136c6ea3b80cdad3a30f8",
"title": "3200d64c33de2ae3bba136c6ea3b80cdad3a30f8",
"url": "https://llvm.googlesource.com/llvm-project/+/3200d64c33de2ae3bba136c6ea3b80cdad3a30f8"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3200d64c33de2ae3bba136c6ea3b80cdad3a30f8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851061274700742320"
},
{
"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"
}
}
[12:40:13.345] Scheduled build:
{
"id": "8685631212820111425",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-02T12:40:12.764941596Z",
"updateTime": "2026-04-02T12:40:12.764941596Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3200d64c33de2ae3bba136c6ea3b80cdad3a30f8",
"ref": "refs/heads/main"
}
}
}
[12:40:13.345] Task URL: https://cr-buildbucket.appspot.com/build/8685631212820111425
[12:40:13.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:2:0) after 2m40s
[12:40:14.009] Received PubSub notification, asking Buildbucket for the build status
[12:40:14.055] Build status: SCHEDULED
[12:40:18.223] Received PubSub notification, asking Buildbucket for the build status
[12:40:18.245] Build status: STARTED
[12:42:53.417] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:2:0)
[12:42:53.438] Build status: STARTED
[12:42:53.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:5:0) after 3m54s
[12:46:47.453] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:5:0)
[12:46:47.533] Build status: STARTED
[12:46:47.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:6:0) after 8m54s
[12:55:41.549] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:6:0)
[12:55:41.610] Build status: STARTED
[12:55:41.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:7:0) after 2m50s
[12:58:31.669] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:7:0)
[12:58:31.683] Build status: STARTED
[12:58:31.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:8:0) after 6m44s
[13:05:15.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:8:0)
[13:05:15.721] Build status: STARTED
[13:05:15.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:9:0) after 1m43s
[13:06:58.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:9:0)
[13:06:58.740] Build status: STARTED
[13:06:58.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:10:0) after 3m10s
[13:10:08.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:10:0)
[13:10:08.833] Build status: STARTED
[13:10:08.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:11:0) after 8m39s
[13:18:47.897] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:11:0)
[13:18:47.965] Build status: STARTED
[13:18:47.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:12:0) after 8m23s
[13:27:10.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:12:0)
[13:27:11.012] Build status: STARTED
[13:27:11.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:13:0) after 2m53s
[13:30:04.059] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:13:0)
[13:30:04.150] Build status: STARTED
[13:30:04.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:14:0) after 2m56s
[13:33:00.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:14:0)
[13:33:00.202] Build status: STARTED
[13:33:00.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:15:0) after 4m25s
[13:37:25.227] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:15:0)
[13:37:25.271] Build status: STARTED
[13:37:25.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:16:0) after 3m14s
[13:40:39.380] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:16:0)
[13:40:39.466] Build status: STARTED
[13:40:39.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:17:0) after 4m55s
[13:45:34.537] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:17:0)
[13:45:34.559] Build status: STARTED
[13:45:34.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:18:0) after 3m56s
[13:49:30.528] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:18:0)
[13:49:30.549] Build status: STARTED
[13:49:30.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:19:0) after 7m19s
[13:56:49.616] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:19:0)
[13:56:49.632] Build status: STARTED
[13:56:49.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:20:0) after 9m39s
[14:06:28.689] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:20:0)
[14:06:28.706] Build status: STARTED
[14:06:28.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:21:0) after 2m28s
[14:08:56.775] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:21:0)
[14:08:56.796] Build status: STARTED
[14:08:56.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8851061274700742320:22:0) after 8m55s
[14:13:58.791] Received PubSub notification, asking Buildbucket for the build status
[14:13:58.993] Build:
{
"id": "8685631212820111425",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-02T12:40:12.764941596Z",
"startTime": "2026-04-02T12:40:17.955644193Z",
"endTime": "2026-04-02T14:13:58.332932176Z",
"updateTime": "2026-04-02T14:13:58.332932176Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3200d64c33de2ae3bba136c6ea3b80cdad3a30f8",
"ref": "refs/heads/main"
}
}
}
[14:13:58.993] Invocation finished in 1h33m47.405454402s with status SUCCEEDED