[16:47:55.772] New invocation is queued and will start shortly
[16:47:57.466] Starting the invocation (attempt 1)
[16:47:57.491] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/87cc613408011b6a13e46ef776d580538db4ea51"
[16:47:57.491] Popped gitiles commit info from properties and tags
[16:47:57.491] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:47:57.491] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:47:57.492] Buildbucket request:
{
"requestId": "8834013458794078096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8834013458794078096",
"job": "fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d7b0c1656f9f9973c62c523724bbccbacb84f83"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d7b0c1656f9f9973c62c523724bbccbacb84f83",
"title": "4d7b0c1656f9f9973c62c523724bbccbacb84f83",
"url": "https://llvm.googlesource.com/llvm-project/+/4d7b0c1656f9f9973c62c523724bbccbacb84f83"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "11620d950883ab2281ee8e15517b858f14188d01"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@11620d950883ab2281ee8e15517b858f14188d01",
"title": "11620d950883ab2281ee8e15517b858f14188d01",
"url": "https://llvm.googlesource.com/llvm-project/+/11620d950883ab2281ee8e15517b858f14188d01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e65c4e339af01d22432188b02e5f4ab9b5e2e47d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e65c4e339af01d22432188b02e5f4ab9b5e2e47d",
"title": "e65c4e339af01d22432188b02e5f4ab9b5e2e47d",
"url": "https://llvm.googlesource.com/llvm-project/+/e65c4e339af01d22432188b02e5f4ab9b5e2e47d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8bf06a4ec674614bb844b29150a1ed4bc595d865"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8bf06a4ec674614bb844b29150a1ed4bc595d865",
"title": "8bf06a4ec674614bb844b29150a1ed4bc595d865",
"url": "https://llvm.googlesource.com/llvm-project/+/8bf06a4ec674614bb844b29150a1ed4bc595d865"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0a7c06cb81000729f527bf4ae664f625adc6dc1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0a7c06cb81000729f527bf4ae664f625adc6dc1",
"title": "a0a7c06cb81000729f527bf4ae664f625adc6dc1",
"url": "https://llvm.googlesource.com/llvm-project/+/a0a7c06cb81000729f527bf4ae664f625adc6dc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "87cc613408011b6a13e46ef776d580538db4ea51"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@87cc613408011b6a13e46ef776d580538db4ea51",
"title": "87cc613408011b6a13e46ef776d580538db4ea51",
"url": "https://llvm.googlesource.com/llvm-project/+/87cc613408011b6a13e46ef776d580538db4ea51"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "87cc613408011b6a13e46ef776d580538db4ea51",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834013458794078096"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:47:57.897] Scheduled build:
{
"id": "8668583396266865841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-07T16:47:57.562848038Z",
"updateTime": "2026-10-07T16:47:57.562848038Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "87cc613408011b6a13e46ef776d580538db4ea51",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:47:57.897] Task URL: https://cr-buildbucket.appspot.com/build/8668583396266865841
[16:47:57.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5:8834013458794078096:2:0) after 8m27s
[16:47:58.224] Received PubSub notification, asking Buildbucket for the build status
[16:47:58.288] Build status: SCHEDULED
[16:48:00.761] Received PubSub notification, asking Buildbucket for the build status
[16:48:00.779] Build status: STARTED
[16:56:24.916] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5:8834013458794078096:2:0)
[16:56:24.936] Build status: STARTED
[16:56:24.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5:8834013458794078096:5:0) after 9m24s
[17:05:48.953] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5:8834013458794078096:5:0)
[17:05:48.975] Build status: STARTED
[17:05:48.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-arm64-40be1bb5:8834013458794078096:6:0) after 7m31s
[17:13:11.764] Received PubSub notification, asking Buildbucket for the build status
[17:13:11.791] Build:
{
"id": "8668583396266865841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-07T16:47:57.562848038Z",
"startTime": "2026-10-07T16:48:00.480040517Z",
"endTime": "2026-10-07T17:13:11.307117911Z",
"updateTime": "2026-10-07T17:13:11.307117911Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "87cc613408011b6a13e46ef776d580538db4ea51",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:13:11.791] Invocation finished in 25m16.023891793s with status SUCCEEDED