[10:58:20.269] New invocation is queued and will start shortly
[10:58:21.521] Starting the invocation (attempt 1)
[10:58:21.551] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/bc25ad46580963afb2056b929b1089133d006dbb"
[10:58:21.551] Popped gitiles commit info from properties and tags
[10:58:21.551] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:21.551] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:21.551] Buildbucket request:
{
"requestId": "8836481571299686928",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836481571299686928",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b2ef39be51f46e2f359f6965588577913765af4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b2ef39be51f46e2f359f6965588577913765af4",
"title": "6b2ef39be51f46e2f359f6965588577913765af4",
"url": "https://llvm.googlesource.com/llvm-project/+/6b2ef39be51f46e2f359f6965588577913765af4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2cd17898705456c546359b0683cbc6fb252698d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2cd17898705456c546359b0683cbc6fb252698d9",
"title": "2cd17898705456c546359b0683cbc6fb252698d9",
"url": "https://llvm.googlesource.com/llvm-project/+/2cd17898705456c546359b0683cbc6fb252698d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9e07d91eb9338f1922adbc120f68cf071bd9c2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9e07d91eb9338f1922adbc120f68cf071bd9c2c",
"title": "c9e07d91eb9338f1922adbc120f68cf071bd9c2c",
"url": "https://llvm.googlesource.com/llvm-project/+/c9e07d91eb9338f1922adbc120f68cf071bd9c2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9679fbfea993cb2e815fe0fa5eefde310f917349"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9679fbfea993cb2e815fe0fa5eefde310f917349",
"title": "9679fbfea993cb2e815fe0fa5eefde310f917349",
"url": "https://llvm.googlesource.com/llvm-project/+/9679fbfea993cb2e815fe0fa5eefde310f917349"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "278e125048fd83b66b6d053c40e31d47b4551884"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@278e125048fd83b66b6d053c40e31d47b4551884",
"title": "278e125048fd83b66b6d053c40e31d47b4551884",
"url": "https://llvm.googlesource.com/llvm-project/+/278e125048fd83b66b6d053c40e31d47b4551884"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a25949882c3ee496b523bcc816974c6ddfa9850"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a25949882c3ee496b523bcc816974c6ddfa9850",
"title": "3a25949882c3ee496b523bcc816974c6ddfa9850",
"url": "https://llvm.googlesource.com/llvm-project/+/3a25949882c3ee496b523bcc816974c6ddfa9850"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d1a8fc4be3dc404bdaf63a493c3acc4cb48db52"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d1a8fc4be3dc404bdaf63a493c3acc4cb48db52",
"title": "8d1a8fc4be3dc404bdaf63a493c3acc4cb48db52",
"url": "https://llvm.googlesource.com/llvm-project/+/8d1a8fc4be3dc404bdaf63a493c3acc4cb48db52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c7e6e9881a42780852d535bfc7d59f63e76642e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c7e6e9881a42780852d535bfc7d59f63e76642e4",
"title": "c7e6e9881a42780852d535bfc7d59f63e76642e4",
"url": "https://llvm.googlesource.com/llvm-project/+/c7e6e9881a42780852d535bfc7d59f63e76642e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0fa0a5db4dd51db8c4ec7f0a68f48f6586e0a29a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0fa0a5db4dd51db8c4ec7f0a68f48f6586e0a29a",
"title": "0fa0a5db4dd51db8c4ec7f0a68f48f6586e0a29a",
"url": "https://llvm.googlesource.com/llvm-project/+/0fa0a5db4dd51db8c4ec7f0a68f48f6586e0a29a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c86292488b86080d994de4164342b8e0fdd43543"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c86292488b86080d994de4164342b8e0fdd43543",
"title": "c86292488b86080d994de4164342b8e0fdd43543",
"url": "https://llvm.googlesource.com/llvm-project/+/c86292488b86080d994de4164342b8e0fdd43543"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb3aad0e4c85c8ce083648297950aa11c46b27e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb3aad0e4c85c8ce083648297950aa11c46b27e4",
"title": "eb3aad0e4c85c8ce083648297950aa11c46b27e4",
"url": "https://llvm.googlesource.com/llvm-project/+/eb3aad0e4c85c8ce083648297950aa11c46b27e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bde886d4e2a244045390da84a8cb9238ad1d3ab7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bde886d4e2a244045390da84a8cb9238ad1d3ab7",
"title": "bde886d4e2a244045390da84a8cb9238ad1d3ab7",
"url": "https://llvm.googlesource.com/llvm-project/+/bde886d4e2a244045390da84a8cb9238ad1d3ab7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3e7900e74098de130402d0a3ea857e77d817540"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3e7900e74098de130402d0a3ea857e77d817540",
"title": "b3e7900e74098de130402d0a3ea857e77d817540",
"url": "https://llvm.googlesource.com/llvm-project/+/b3e7900e74098de130402d0a3ea857e77d817540"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2ba88c9a5ce27c4a90a14c4190f3c41c6069e92"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2ba88c9a5ce27c4a90a14c4190f3c41c6069e92",
"title": "f2ba88c9a5ce27c4a90a14c4190f3c41c6069e92",
"url": "https://llvm.googlesource.com/llvm-project/+/f2ba88c9a5ce27c4a90a14c4190f3c41c6069e92"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5bb6f55462541521488c0bbd59e028ee891f829b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5bb6f55462541521488c0bbd59e028ee891f829b",
"title": "5bb6f55462541521488c0bbd59e028ee891f829b",
"url": "https://llvm.googlesource.com/llvm-project/+/5bb6f55462541521488c0bbd59e028ee891f829b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c52a3432d6a8187dd0f22ad1f8fde6774167dc89"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c52a3432d6a8187dd0f22ad1f8fde6774167dc89",
"title": "c52a3432d6a8187dd0f22ad1f8fde6774167dc89",
"url": "https://llvm.googlesource.com/llvm-project/+/c52a3432d6a8187dd0f22ad1f8fde6774167dc89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bc25ad46580963afb2056b929b1089133d006dbb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bc25ad46580963afb2056b929b1089133d006dbb",
"title": "bc25ad46580963afb2056b929b1089133d006dbb",
"url": "https://llvm.googlesource.com/llvm-project/+/bc25ad46580963afb2056b929b1089133d006dbb"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc25ad46580963afb2056b929b1089133d006dbb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836481571299686928"
},
{
"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"
}
}
[10:58:21.930] Scheduled build:
{
"id": "8671051509218803761",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-10T10:58:21.630649125Z",
"updateTime": "2026-09-10T10:58:21.630649125Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc25ad46580963afb2056b929b1089133d006dbb",
"ref": "refs/heads/main"
}
}
}
[10:58:21.930] Task URL: https://cr-buildbucket.appspot.com/build/8671051509218803761
[10:58:21.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:2:0) after 3m27s
[10:58:22.887] Received PubSub notification, asking Buildbucket for the build status
[10:58:22.905] Build status: SCHEDULED
[10:58:27.061] Received PubSub notification, asking Buildbucket for the build status
[10:58:27.080] Build status: STARTED
[11:01:48.898] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:2:0)
[11:01:48.915] Build status: STARTED
[11:01:48.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:5:0) after 6m40s
[11:08:28.985] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:5:0)
[11:08:29.015] Build status: STARTED
[11:08:29.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:6:0) after 4m16s
[11:12:45.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:6:0)
[11:12:45.093] Build status: STARTED
[11:12:45.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:7:0) after 5m1s
[11:17:46.112] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:7:0)
[11:17:46.142] Build status: STARTED
[11:17:46.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:8:0) after 5m21s
[11:23:07.208] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:8:0)
[11:23:07.224] Build status: STARTED
[11:23:07.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:9:0) after 5m51s
[11:28:58.242] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:9:0)
[11:28:58.267] Build status: STARTED
[11:28:58.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:10:0) after 8m37s
[11:37:35.287] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:10:0)
[11:37:35.307] Build status: STARTED
[11:37:35.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:11:0) after 2m7s
[11:39:42.328] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:11:0)
[11:39:42.356] Build status: STARTED
[11:39:42.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:12:0) after 4m15s
[11:43:57.335] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:12:0)
[11:43:57.354] Build status: STARTED
[11:43:57.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:13:0) after 9m8s
[11:53:05.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:13:0)
[11:53:05.446] Build status: STARTED
[11:53:05.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:14:0) after 2m28s
[11:55:33.515] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:14:0)
[11:55:33.545] Build status: STARTED
[11:55:33.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:15:0) after 9m5s
[12:04:38.697] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:15:0)
[12:04:38.717] Build status: STARTED
[12:04:38.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:16:0) after 4m40s
[12:09:18.739] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:16:0)
[12:09:18.771] Build status: STARTED
[12:09:18.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:17:0) after 5m39s
[12:14:57.892] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:17:0)
[12:14:57.911] Build status: STARTED
[12:14:57.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:18:0) after 9m46s
[12:24:43.960] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:18:0)
[12:24:43.987] Build status: STARTED
[12:24:43.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:19:0) after 7m32s
[12:32:15.992] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:19:0)
[12:32:16.016] Build status: STARTED
[12:32:16.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:20:0) after 2m36s
[12:34:52.083] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:20:0)
[12:34:52.102] Build status: STARTED
[12:34:52.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:21:0) after 5m17s
[12:40:09.121] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:21:0)
[12:40:09.142] Build status: STARTED
[12:40:09.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:22:0) after 4m56s
[12:45:05.281] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:22:0)
[12:45:05.302] Build status: STARTED
[12:45:05.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:23:0) after 2m8s
[12:47:13.281] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:23:0)
[12:47:13.301] Build status: STARTED
[12:47:13.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8836481571299686928:24:0) after 4m45s
[12:51:11.461] Received PubSub notification, asking Buildbucket for the build status
[12:51:11.495] Build:
{
"id": "8671051509218803761",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-10T10:58:21.630649125Z",
"startTime": "2026-09-10T10:58:26.863421031Z",
"endTime": "2026-09-10T12:51:10.895371507Z",
"updateTime": "2026-09-10T12:51:10.895371507Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc25ad46580963afb2056b929b1089133d006dbb",
"ref": "refs/heads/main"
}
}
}
[12:51:11.495] Invocation finished in 1h52m51.232807822s with status SUCCEEDED