[18:41:25.212] New invocation is queued and will start shortly
[18:41:26.860] Starting the invocation (attempt 1)
[18:41:26.886] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e0f4988ddc6e56d794d0bfb55216254c4fd59848"
[18:41:26.887] Popped gitiles commit info from properties and tags
[18:41:26.887] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:41:26.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:41:26.887] Buildbucket request:
{
"requestId": "8858195708612948096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858195708612948096",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa299269eae40dd7f25a41f1885d6db16ffc9105"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa299269eae40dd7f25a41f1885d6db16ffc9105",
"title": "aa299269eae40dd7f25a41f1885d6db16ffc9105",
"url": "https://llvm.googlesource.com/llvm-project/+/aa299269eae40dd7f25a41f1885d6db16ffc9105"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0316441d5ca6cb4bab3dc4e27a3794992eb5cbf5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0316441d5ca6cb4bab3dc4e27a3794992eb5cbf5",
"title": "0316441d5ca6cb4bab3dc4e27a3794992eb5cbf5",
"url": "https://llvm.googlesource.com/llvm-project/+/0316441d5ca6cb4bab3dc4e27a3794992eb5cbf5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a69bccce9ec985ee875154b0a0689be1facc0df"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a69bccce9ec985ee875154b0a0689be1facc0df",
"title": "0a69bccce9ec985ee875154b0a0689be1facc0df",
"url": "https://llvm.googlesource.com/llvm-project/+/0a69bccce9ec985ee875154b0a0689be1facc0df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "377efc730beb292d1f51025d51ea27d86196ff06"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@377efc730beb292d1f51025d51ea27d86196ff06",
"title": "377efc730beb292d1f51025d51ea27d86196ff06",
"url": "https://llvm.googlesource.com/llvm-project/+/377efc730beb292d1f51025d51ea27d86196ff06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f07877b2ea748b6f778cb5f3901127f6cad1c26f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f07877b2ea748b6f778cb5f3901127f6cad1c26f",
"title": "f07877b2ea748b6f778cb5f3901127f6cad1c26f",
"url": "https://llvm.googlesource.com/llvm-project/+/f07877b2ea748b6f778cb5f3901127f6cad1c26f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bd40d567e068e0b523b4af7a65604b9eec50005f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bd40d567e068e0b523b4af7a65604b9eec50005f",
"title": "bd40d567e068e0b523b4af7a65604b9eec50005f",
"url": "https://llvm.googlesource.com/llvm-project/+/bd40d567e068e0b523b4af7a65604b9eec50005f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb2c5b1b2bd67274486d19bd5fb30f9a1c7952b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb2c5b1b2bd67274486d19bd5fb30f9a1c7952b8",
"title": "fb2c5b1b2bd67274486d19bd5fb30f9a1c7952b8",
"url": "https://llvm.googlesource.com/llvm-project/+/fb2c5b1b2bd67274486d19bd5fb30f9a1c7952b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a05f603c71240f46235586f9d85ad84c05c09538"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a05f603c71240f46235586f9d85ad84c05c09538",
"title": "a05f603c71240f46235586f9d85ad84c05c09538",
"url": "https://llvm.googlesource.com/llvm-project/+/a05f603c71240f46235586f9d85ad84c05c09538"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "18c5225d649dcd24c941a5f716c056947994094c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@18c5225d649dcd24c941a5f716c056947994094c",
"title": "18c5225d649dcd24c941a5f716c056947994094c",
"url": "https://llvm.googlesource.com/llvm-project/+/18c5225d649dcd24c941a5f716c056947994094c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c461d3cf5e8b9cd2e930d7a275ecdd485b6fcc29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c461d3cf5e8b9cd2e930d7a275ecdd485b6fcc29",
"title": "c461d3cf5e8b9cd2e930d7a275ecdd485b6fcc29",
"url": "https://llvm.googlesource.com/llvm-project/+/c461d3cf5e8b9cd2e930d7a275ecdd485b6fcc29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2dca9aa9d6db3b5eab4e8b9d3274a5d86d4e3905"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2dca9aa9d6db3b5eab4e8b9d3274a5d86d4e3905",
"title": "2dca9aa9d6db3b5eab4e8b9d3274a5d86d4e3905",
"url": "https://llvm.googlesource.com/llvm-project/+/2dca9aa9d6db3b5eab4e8b9d3274a5d86d4e3905"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8784816a419069b68aa0f798dc882d70e0176fdd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8784816a419069b68aa0f798dc882d70e0176fdd",
"title": "8784816a419069b68aa0f798dc882d70e0176fdd",
"url": "https://llvm.googlesource.com/llvm-project/+/8784816a419069b68aa0f798dc882d70e0176fdd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2a521750aa867d82218e00ff5168c62b5b5ce25"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2a521750aa867d82218e00ff5168c62b5b5ce25",
"title": "d2a521750aa867d82218e00ff5168c62b5b5ce25",
"url": "https://llvm.googlesource.com/llvm-project/+/d2a521750aa867d82218e00ff5168c62b5b5ce25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1c305aebd640cd43d1c8529049bb9a5463c9c562"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1c305aebd640cd43d1c8529049bb9a5463c9c562",
"title": "1c305aebd640cd43d1c8529049bb9a5463c9c562",
"url": "https://llvm.googlesource.com/llvm-project/+/1c305aebd640cd43d1c8529049bb9a5463c9c562"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c752e12b7622d0ee3483148620fd9d4e97055a3b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c752e12b7622d0ee3483148620fd9d4e97055a3b",
"title": "c752e12b7622d0ee3483148620fd9d4e97055a3b",
"url": "https://llvm.googlesource.com/llvm-project/+/c752e12b7622d0ee3483148620fd9d4e97055a3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "458a2e88cc0595e5456e37cdfbec9bd84d5e2dee"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@458a2e88cc0595e5456e37cdfbec9bd84d5e2dee",
"title": "458a2e88cc0595e5456e37cdfbec9bd84d5e2dee",
"url": "https://llvm.googlesource.com/llvm-project/+/458a2e88cc0595e5456e37cdfbec9bd84d5e2dee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "511e6040cc3e7682dde1542ac049775e502724dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@511e6040cc3e7682dde1542ac049775e502724dd",
"title": "511e6040cc3e7682dde1542ac049775e502724dd",
"url": "https://llvm.googlesource.com/llvm-project/+/511e6040cc3e7682dde1542ac049775e502724dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "965662ea0104f6f3e9394589552c625fd8959017"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@965662ea0104f6f3e9394589552c625fd8959017",
"title": "965662ea0104f6f3e9394589552c625fd8959017",
"url": "https://llvm.googlesource.com/llvm-project/+/965662ea0104f6f3e9394589552c625fd8959017"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0f4988ddc6e56d794d0bfb55216254c4fd59848"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0f4988ddc6e56d794d0bfb55216254c4fd59848",
"title": "e0f4988ddc6e56d794d0bfb55216254c4fd59848",
"url": "https://llvm.googlesource.com/llvm-project/+/e0f4988ddc6e56d794d0bfb55216254c4fd59848"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e0f4988ddc6e56d794d0bfb55216254c4fd59848",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858195708612948096"
},
{
"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:41:27.254] Scheduled build:
{
"id": "8692765646102555665",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-13T18:41:26.981323253Z",
"updateTime": "2026-01-13T18:41:26.981323253Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e0f4988ddc6e56d794d0bfb55216254c4fd59848",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:41:27.254] Task URL: https://cr-buildbucket.appspot.com/build/8692765646102555665
[18:41:27.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:2:0) after 7m38s
[18:41:27.418] Received PubSub notification, asking Buildbucket for the build status
[18:41:27.434] Build status: SCHEDULED
[18:42:18.431] Received PubSub notification, asking Buildbucket for the build status
[18:42:18.449] Build status: STARTED
[18:49:05.321] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:2:0)
[18:49:05.337] Build status: STARTED
[18:49:05.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:5:0) after 8m30s
[18:57:35.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:5:0)
[18:57:35.358] Build status: STARTED
[18:57:35.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:6:0) after 3m44s
[19:01:19.375] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:6:0)
[19:01:19.448] Build status: STARTED
[19:01:19.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:7:0) after 1m49s
[19:03:08.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:7:0)
[19:03:08.447] Build status: STARTED
[19:03:08.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:8:0) after 1m49s
[19:04:57.440] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:8:0)
[19:04:57.464] Build status: STARTED
[19:04:57.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:9:0) after 5m59s
[19:10:56.483] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:9:0)
[19:10:56.502] Build status: STARTED
[19:10:56.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:10:0) after 6m27s
[19:17:23.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:10:0)
[19:17:23.740] Build status: STARTED
[19:17:23.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:11:0) after 3m48s
[19:21:11.787] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:11:0)
[19:21:11.804] Build status: STARTED
[19:21:11.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:12:0) after 4m51s
[19:26:02.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:12:0)
[19:26:02.850] Build status: STARTED
[19:26:02.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:13:0) after 6m9s
[19:32:11.914] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:13:0)
[19:32:11.978] Build status: STARTED
[19:32:11.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:14:0) after 8m53s
[19:41:05.139] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:14:0)
[19:41:05.159] Build status: STARTED
[19:41:05.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:15:0) after 1m28s
[19:42:33.178] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:15:0)
[19:42:33.194] Build status: STARTED
[19:42:33.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:16:0) after 3m18s
[19:45:51.262] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:16:0)
[19:45:51.299] Build status: STARTED
[19:45:51.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:17:0) after 1m3s
[19:46:54.316] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:17:0)
[19:46:54.333] Build status: STARTED
[19:46:54.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:18:0) after 5m8s
[19:52:02.349] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:18:0)
[19:52:02.420] Build status: STARTED
[19:52:02.420] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:19:0) after 2m21s
[19:54:23.442] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:19:0)
[19:54:23.461] Build status: STARTED
[19:54:23.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:20:0) after 2m0s
[19:56:23.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:20:0)
[19:56:23.501] Build status: STARTED
[19:56:23.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:21:0) after 5m34s
[20:01:57.528] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:21:0)
[20:01:57.544] Build status: STARTED
[20:01:57.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:22:0) after 4m13s
[20:06:10.561] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:22:0)
[20:06:10.583] Build status: STARTED
[20:06:10.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:23:0) after 3m13s
[20:09:23.633] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:23:0)
[20:09:23.648] Build status: STARTED
[20:09:23.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:24:0) after 2m51s
[20:12:14.665] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:24:0)
[20:12:14.694] Build status: STARTED
[20:12:14.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:25:0) after 7m29s
[20:19:43.764] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:25:0)
[20:19:43.854] Build status: STARTED
[20:19:43.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858195708612948096:26:0) after 4m12s
[20:20:11.333] Received PubSub notification, asking Buildbucket for the build status
[20:20:11.352] Build:
{
"id": "8692765646102555665",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-13T18:41:26.981323253Z",
"startTime": "2026-01-13T18:42:18.268633426Z",
"endTime": "2026-01-13T20:20:10.746115362Z",
"updateTime": "2026-01-13T20:20:10.746115362Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e0f4988ddc6e56d794d0bfb55216254c4fd59848",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:20:11.352] Invocation finished in 1h38m46.148817021s with status SUCCEEDED