[08:24:11.551] New invocation is queued and will start shortly
[08:24:12.985] Starting the invocation (attempt 1)
[08:24:13.027] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2780b8f22058b35a8e70045858b87a1966df8df3"
[08:24:13.027] Popped gitiles commit info from properties and tags
[08:24:13.027] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:24:13.027] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:24:13.028] Buildbucket request:
{
"requestId": "8873454831585949872",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873454831585949872",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ecefba52d3ea7e0d028dd4b745766cb5627121f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ecefba52d3ea7e0d028dd4b745766cb5627121f",
"title": "3ecefba52d3ea7e0d028dd4b745766cb5627121f",
"url": "https://llvm.googlesource.com/llvm-project/+/3ecefba52d3ea7e0d028dd4b745766cb5627121f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "267eb81d5b92294275881f149a9e6bc5b87c0546"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@267eb81d5b92294275881f149a9e6bc5b87c0546",
"title": "267eb81d5b92294275881f149a9e6bc5b87c0546",
"url": "https://llvm.googlesource.com/llvm-project/+/267eb81d5b92294275881f149a9e6bc5b87c0546"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b020d5434078145e2fd2b4f1a48bb1c78ace491"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b020d5434078145e2fd2b4f1a48bb1c78ace491",
"title": "8b020d5434078145e2fd2b4f1a48bb1c78ace491",
"url": "https://llvm.googlesource.com/llvm-project/+/8b020d5434078145e2fd2b4f1a48bb1c78ace491"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dcff52312375bbaa1edc65e0ace9c15623a9c8ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dcff52312375bbaa1edc65e0ace9c15623a9c8ab",
"title": "dcff52312375bbaa1edc65e0ace9c15623a9c8ab",
"url": "https://llvm.googlesource.com/llvm-project/+/dcff52312375bbaa1edc65e0ace9c15623a9c8ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ea3e334cc19cdd34416b546ac4b4a24b2018a28"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ea3e334cc19cdd34416b546ac4b4a24b2018a28",
"title": "3ea3e334cc19cdd34416b546ac4b4a24b2018a28",
"url": "https://llvm.googlesource.com/llvm-project/+/3ea3e334cc19cdd34416b546ac4b4a24b2018a28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c8749608bf44dd6e528305b242c7bd238cfb405"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c8749608bf44dd6e528305b242c7bd238cfb405",
"title": "8c8749608bf44dd6e528305b242c7bd238cfb405",
"url": "https://llvm.googlesource.com/llvm-project/+/8c8749608bf44dd6e528305b242c7bd238cfb405"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "144ae251aaf5f36310b9e3ef67e9d6d6e2fbf9c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@144ae251aaf5f36310b9e3ef67e9d6d6e2fbf9c0",
"title": "144ae251aaf5f36310b9e3ef67e9d6d6e2fbf9c0",
"url": "https://llvm.googlesource.com/llvm-project/+/144ae251aaf5f36310b9e3ef67e9d6d6e2fbf9c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59013d44058ef423a117f95092150e16e16fdb09"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59013d44058ef423a117f95092150e16e16fdb09",
"title": "59013d44058ef423a117f95092150e16e16fdb09",
"url": "https://llvm.googlesource.com/llvm-project/+/59013d44058ef423a117f95092150e16e16fdb09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3eee9fc2c4d1973904b1a26fa96a8c7473ef6a5e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3eee9fc2c4d1973904b1a26fa96a8c7473ef6a5e",
"title": "3eee9fc2c4d1973904b1a26fa96a8c7473ef6a5e",
"url": "https://llvm.googlesource.com/llvm-project/+/3eee9fc2c4d1973904b1a26fa96a8c7473ef6a5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4745637e44bc1aaac342bd78d1f13a92caa59fde"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4745637e44bc1aaac342bd78d1f13a92caa59fde",
"title": "4745637e44bc1aaac342bd78d1f13a92caa59fde",
"url": "https://llvm.googlesource.com/llvm-project/+/4745637e44bc1aaac342bd78d1f13a92caa59fde"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6fbc397964340ebc9cb04a094fd04bef9a53abc3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6fbc397964340ebc9cb04a094fd04bef9a53abc3",
"title": "6fbc397964340ebc9cb04a094fd04bef9a53abc3",
"url": "https://llvm.googlesource.com/llvm-project/+/6fbc397964340ebc9cb04a094fd04bef9a53abc3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab1f6ce482487d0f276159a57775c0b3917da6ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab1f6ce482487d0f276159a57775c0b3917da6ec",
"title": "ab1f6ce482487d0f276159a57775c0b3917da6ec",
"url": "https://llvm.googlesource.com/llvm-project/+/ab1f6ce482487d0f276159a57775c0b3917da6ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fc90685354ca36c935ebb0f315bb18592598a83b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fc90685354ca36c935ebb0f315bb18592598a83b",
"title": "fc90685354ca36c935ebb0f315bb18592598a83b",
"url": "https://llvm.googlesource.com/llvm-project/+/fc90685354ca36c935ebb0f315bb18592598a83b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d5985905ae8e5b2e108d1b2772b554134db162dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d5985905ae8e5b2e108d1b2772b554134db162dd",
"title": "d5985905ae8e5b2e108d1b2772b554134db162dd",
"url": "https://llvm.googlesource.com/llvm-project/+/d5985905ae8e5b2e108d1b2772b554134db162dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d21522c00e2bda466834b43af5839eedc4e36bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d21522c00e2bda466834b43af5839eedc4e36bd",
"title": "0d21522c00e2bda466834b43af5839eedc4e36bd",
"url": "https://llvm.googlesource.com/llvm-project/+/0d21522c00e2bda466834b43af5839eedc4e36bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5dab1fa1fa174085a9f265ff25763a31af97c9e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5dab1fa1fa174085a9f265ff25763a31af97c9e3",
"title": "5dab1fa1fa174085a9f265ff25763a31af97c9e3",
"url": "https://llvm.googlesource.com/llvm-project/+/5dab1fa1fa174085a9f265ff25763a31af97c9e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2780b8f22058b35a8e70045858b87a1966df8df3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2780b8f22058b35a8e70045858b87a1966df8df3",
"title": "2780b8f22058b35a8e70045858b87a1966df8df3",
"url": "https://llvm.googlesource.com/llvm-project/+/2780b8f22058b35a8e70045858b87a1966df8df3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2780b8f22058b35a8e70045858b87a1966df8df3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873454831585949872"
},
{
"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"
}
}
[08:24:13.494] Scheduled build:
{
"id": "8708024769299364241",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-29T08:24:13.097202678Z",
"updateTime": "2025-07-29T08:24:13.097202678Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2780b8f22058b35a8e70045858b87a1966df8df3",
"ref": "refs/heads/main"
}
}
}
[08:24:13.494] Task URL: https://cr-buildbucket.appspot.com/build/8708024769299364241
[08:24:13.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:2:0) after 7m34s
[08:24:13.569] Received PubSub notification, asking Buildbucket for the build status
[08:24:14.252] Build status: SCHEDULED
[08:24:18.321] Received PubSub notification, asking Buildbucket for the build status
[08:24:18.338] Build status: STARTED
[08:31:47.513] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:2:0)
[08:31:47.534] Build status: STARTED
[08:31:47.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:5:0) after 6m31s
[08:38:18.577] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:5:0)
[08:38:18.618] Build status: STARTED
[08:38:18.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:6:0) after 4m45s
[08:43:03.631] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:6:0)
[08:43:03.662] Build status: STARTED
[08:43:03.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:7:0) after 4m23s
[08:47:26.681] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:7:0)
[08:47:26.709] Build status: STARTED
[08:47:26.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:8:0) after 4m46s
[08:52:12.787] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:8:0)
[08:52:12.809] Build status: STARTED
[08:52:12.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:9:0) after 4m46s
[08:56:58.831] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:9:0)
[08:56:58.860] Build status: STARTED
[08:56:58.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:10:0) after 6m51s
[09:03:49.882] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:10:0)
[09:03:49.902] Build status: STARTED
[09:03:49.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:11:0) after 4m30s
[09:08:19.909] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:11:0)
[09:08:19.970] Build status: STARTED
[09:08:19.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:12:0) after 2m57s
[09:11:17.008] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:12:0)
[09:11:17.053] Build status: STARTED
[09:11:17.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:13:0) after 1m11s
[09:12:28.076] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:13:0)
[09:12:28.099] Build status: STARTED
[09:12:28.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:14:0) after 3m32s
[09:16:00.167] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:14:0)
[09:16:00.197] Build status: STARTED
[09:16:00.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:15:0) after 6m11s
[09:22:11.224] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:15:0)
[09:22:11.248] Build status: STARTED
[09:22:11.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:16:0) after 2m16s
[09:24:27.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:16:0)
[09:24:27.295] Build status: STARTED
[09:24:27.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:17:0) after 2m8s
[09:26:35.415] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:17:0)
[09:26:35.441] Build status: STARTED
[09:26:35.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:18:0) after 5m11s
[09:31:46.468] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:18:0)
[09:31:46.497] Build status: STARTED
[09:31:46.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:19:0) after 3m5s
[09:34:52.024] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:19:0)
[09:34:52.053] Build status: STARTED
[09:34:52.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:20:0) after 7m0s
[09:41:52.057] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:20:0)
[09:41:52.077] Build status: STARTED
[09:41:52.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:21:0) after 7m24s
[09:49:16.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:21:0)
[09:49:16.336] Build status: STARTED
[09:49:16.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:22:0) after 4m55s
[09:54:11.558] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:22:0)
[09:54:11.604] Build status: STARTED
[09:54:11.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:23:0) after 2m58s
[09:57:09.586] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:23:0)
[09:57:09.646] Build status: STARTED
[09:57:09.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873454831585949872:24:0) after 5m27s
[09:57:19.931] Received PubSub notification, asking Buildbucket for the build status
[09:57:19.954] Build:
{
"id": "8708024769299364241",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-29T08:24:13.097202678Z",
"startTime": "2025-07-29T08:24:18.144423574Z",
"endTime": "2025-07-29T09:57:19.494392591Z",
"updateTime": "2025-07-29T09:57:19.494392591Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2780b8f22058b35a8e70045858b87a1966df8df3",
"ref": "refs/heads/main"
}
}
}
[09:57:19.954] Invocation finished in 1h33m8.42092298s with status SUCCEEDED