[16:26:12.229] New invocation is queued and will start shortly
[16:26:13.281] Starting the invocation (attempt 1)
[16:26:13.314] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0cdaa8f6120274fe3915c1aa9a208eaeee3c572f"
[16:26:13.314] Popped gitiles commit info from properties and tags
[16:26:13.314] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:26:13.314] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:26:13.314] Buildbucket request:
{
"requestId": "8858023021766168720",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858023021766168720",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bde808bf1ccf4ba95011a08468c23d4cdfc5573c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bde808bf1ccf4ba95011a08468c23d4cdfc5573c",
"title": "bde808bf1ccf4ba95011a08468c23d4cdfc5573c",
"url": "https://llvm.googlesource.com/llvm-project/+/bde808bf1ccf4ba95011a08468c23d4cdfc5573c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6fd8c36417709118e154d83559c08ce829bfe17d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6fd8c36417709118e154d83559c08ce829bfe17d",
"title": "6fd8c36417709118e154d83559c08ce829bfe17d",
"url": "https://llvm.googlesource.com/llvm-project/+/6fd8c36417709118e154d83559c08ce829bfe17d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "72a20b8e29876106aa918d03ef95f27a6bf0fa0d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@72a20b8e29876106aa918d03ef95f27a6bf0fa0d",
"title": "72a20b8e29876106aa918d03ef95f27a6bf0fa0d",
"url": "https://llvm.googlesource.com/llvm-project/+/72a20b8e29876106aa918d03ef95f27a6bf0fa0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fc10fbb71e5447d539058dd09286e202fcdf23fa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fc10fbb71e5447d539058dd09286e202fcdf23fa",
"title": "fc10fbb71e5447d539058dd09286e202fcdf23fa",
"url": "https://llvm.googlesource.com/llvm-project/+/fc10fbb71e5447d539058dd09286e202fcdf23fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "513062dd583dc65e29987f3716f5b6fa9c1b4fe9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@513062dd583dc65e29987f3716f5b6fa9c1b4fe9",
"title": "513062dd583dc65e29987f3716f5b6fa9c1b4fe9",
"url": "https://llvm.googlesource.com/llvm-project/+/513062dd583dc65e29987f3716f5b6fa9c1b4fe9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8660308108fdc9c0c7962a070b2e0d07349c5e8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8660308108fdc9c0c7962a070b2e0d07349c5e8",
"title": "a8660308108fdc9c0c7962a070b2e0d07349c5e8",
"url": "https://llvm.googlesource.com/llvm-project/+/a8660308108fdc9c0c7962a070b2e0d07349c5e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "282a065c5bb36186c05b903980d1d3a37fce2175"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@282a065c5bb36186c05b903980d1d3a37fce2175",
"title": "282a065c5bb36186c05b903980d1d3a37fce2175",
"url": "https://llvm.googlesource.com/llvm-project/+/282a065c5bb36186c05b903980d1d3a37fce2175"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "444adbe53472582f3f077fa1a16e52df97caddb8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@444adbe53472582f3f077fa1a16e52df97caddb8",
"title": "444adbe53472582f3f077fa1a16e52df97caddb8",
"url": "https://llvm.googlesource.com/llvm-project/+/444adbe53472582f3f077fa1a16e52df97caddb8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d616cdca3aba9d22f120888bb6b09b75ca90b92"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d616cdca3aba9d22f120888bb6b09b75ca90b92",
"title": "1d616cdca3aba9d22f120888bb6b09b75ca90b92",
"url": "https://llvm.googlesource.com/llvm-project/+/1d616cdca3aba9d22f120888bb6b09b75ca90b92"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e39d44c430228a6d162beae87d72d157107a7e24"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e39d44c430228a6d162beae87d72d157107a7e24",
"title": "e39d44c430228a6d162beae87d72d157107a7e24",
"url": "https://llvm.googlesource.com/llvm-project/+/e39d44c430228a6d162beae87d72d157107a7e24"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6309cd8668fc2ae589f156b23f86821f4ce5b7ea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6309cd8668fc2ae589f156b23f86821f4ce5b7ea",
"title": "6309cd8668fc2ae589f156b23f86821f4ce5b7ea",
"url": "https://llvm.googlesource.com/llvm-project/+/6309cd8668fc2ae589f156b23f86821f4ce5b7ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e493b86c57bc65595db4f269c2f013785df924f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e493b86c57bc65595db4f269c2f013785df924f",
"title": "8e493b86c57bc65595db4f269c2f013785df924f",
"url": "https://llvm.googlesource.com/llvm-project/+/8e493b86c57bc65595db4f269c2f013785df924f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4d4caad946619841ea924526204ee99b99435d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4d4caad946619841ea924526204ee99b99435d2",
"title": "f4d4caad946619841ea924526204ee99b99435d2",
"url": "https://llvm.googlesource.com/llvm-project/+/f4d4caad946619841ea924526204ee99b99435d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1727337d8e0f535526cfd12d1d1666910a79e14b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1727337d8e0f535526cfd12d1d1666910a79e14b",
"title": "1727337d8e0f535526cfd12d1d1666910a79e14b",
"url": "https://llvm.googlesource.com/llvm-project/+/1727337d8e0f535526cfd12d1d1666910a79e14b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3150b73dec83d76321727a3c01a7907485bec6ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3150b73dec83d76321727a3c01a7907485bec6ce",
"title": "3150b73dec83d76321727a3c01a7907485bec6ce",
"url": "https://llvm.googlesource.com/llvm-project/+/3150b73dec83d76321727a3c01a7907485bec6ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5acb608b5265b37b2c5dbd5a1699c3d129935d95"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5acb608b5265b37b2c5dbd5a1699c3d129935d95",
"title": "5acb608b5265b37b2c5dbd5a1699c3d129935d95",
"url": "https://llvm.googlesource.com/llvm-project/+/5acb608b5265b37b2c5dbd5a1699c3d129935d95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0cdaa8f6120274fe3915c1aa9a208eaeee3c572f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0cdaa8f6120274fe3915c1aa9a208eaeee3c572f",
"title": "0cdaa8f6120274fe3915c1aa9a208eaeee3c572f",
"url": "https://llvm.googlesource.com/llvm-project/+/0cdaa8f6120274fe3915c1aa9a208eaeee3c572f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0cdaa8f6120274fe3915c1aa9a208eaeee3c572f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858023021766168720"
},
{
"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"
}
}
[16:26:13.808] Scheduled build:
{
"id": "8692592959910532721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-15T16:26:13.367905621Z",
"updateTime": "2026-01-15T16:26:13.367905621Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0cdaa8f6120274fe3915c1aa9a208eaeee3c572f",
"ref": "refs/heads/main"
}
}
}
[16:26:13.808] Task URL: https://cr-buildbucket.appspot.com/build/8692592959910532721
[16:26:13.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:2:0) after 4m20s
[16:26:14.002] Received PubSub notification, asking Buildbucket for the build status
[16:26:14.021] Build status: SCHEDULED
[16:30:33.798] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:2:0)
[16:30:33.825] Build status: SCHEDULED
[16:30:33.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:4:0) after 1m16s
[16:31:49.841] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:4:0)
[16:31:49.864] Build status: SCHEDULED
[16:31:49.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:5:0) after 5m40s
[16:37:29.889] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:5:0)
[16:37:29.905] Build status: SCHEDULED
[16:37:29.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:6:0) after 6m4s
[16:43:33.962] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:6:0)
[16:43:33.978] Build status: SCHEDULED
[16:43:33.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:7:0) after 5m31s
[16:49:05.145] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:7:0)
[16:49:05.180] Build status: SCHEDULED
[16:49:05.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:8:0) after 9m44s
[16:58:49.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:8:0)
[16:58:49.249] Build status: SCHEDULED
[16:58:49.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:9:0) after 5m45s
[16:59:18.007] Received PubSub notification, asking Buildbucket for the build status
[16:59:18.025] Build status: STARTED
[17:04:34.267] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:9:0)
[17:04:34.285] Build status: STARTED
[17:04:34.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:11:0) after 7m52s
[17:12:26.286] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:11:0)
[17:12:26.325] Build status: STARTED
[17:12:26.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:12:0) after 2m12s
[17:14:38.354] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:12:0)
[17:14:38.369] Build status: STARTED
[17:14:38.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:13:0) after 4m51s
[17:19:29.384] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:13:0)
[17:19:29.398] Build status: STARTED
[17:19:29.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:14:0) after 2m51s
[17:22:20.419] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:14:0)
[17:22:20.442] Build status: STARTED
[17:22:20.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:15:0) after 2m27s
[17:24:47.479] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:15:0)
[17:24:47.504] Build status: STARTED
[17:24:47.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:16:0) after 5m38s
[17:30:25.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:16:0)
[17:30:25.583] Build status: STARTED
[17:30:25.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:17:0) after 1m30s
[17:31:55.650] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:17:0)
[17:31:55.665] Build status: STARTED
[17:31:55.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:18:0) after 5m54s
[17:37:49.682] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:18:0)
[17:37:49.706] Build status: STARTED
[17:37:49.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:19:0) after 4m43s
[17:42:32.720] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:19:0)
[17:42:32.740] Build status: STARTED
[17:42:32.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:20:0) after 6m53s
[17:49:25.761] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:20:0)
[17:49:25.779] Build status: STARTED
[17:49:25.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:21:0) after 3m7s
[17:52:32.785] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:21:0)
[17:52:32.805] Build status: STARTED
[17:52:32.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:22:0) after 6m20s
[17:58:52.910] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:22:0)
[17:58:52.932] Build status: STARTED
[17:58:52.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:23:0) after 8m19s
[18:07:11.952] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:23:0)
[18:07:11.972] Build status: STARTED
[18:07:11.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:24:0) after 2m38s
[18:09:49.986] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:24:0)
[18:09:50.077] Build status: STARTED
[18:09:50.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:25:0) after 8m2s
[18:17:52.126] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:25:0)
[18:17:52.144] Build status: STARTED
[18:17:52.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:26:0) after 4m28s
[18:22:20.163] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:26:0)
[18:22:20.180] Build status: STARTED
[18:22:20.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:27:0) after 9m9s
[18:31:29.200] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:27:0)
[18:31:29.444] Build status: STARTED
[18:31:29.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:28:0) after 3m7s
[18:34:36.461] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:28:0)
[18:34:36.477] Build status: STARTED
[18:34:36.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858023021766168720:29:0) after 7m7s
[18:38:29.659] Received PubSub notification, asking Buildbucket for the build status
[18:38:29.680] Build:
{
"id": "8692592959910532721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-15T16:26:13.367905621Z",
"startTime": "2026-01-15T16:59:17.862702058Z",
"endTime": "2026-01-15T18:38:29.312130644Z",
"updateTime": "2026-01-15T18:38:29.312130644Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0cdaa8f6120274fe3915c1aa9a208eaeee3c572f",
"ref": "refs/heads/main"
}
}
}
[18:38:29.680] Invocation finished in 2h12m17.465627046s with status SUCCEEDED