[15:43:18.257] New invocation is queued and will start shortly
[15:43:19.347] Starting the invocation (attempt 1)
[15:43:19.375] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff616a192bb486915200675d7be33dc042deca24"
[15:43:19.375] Popped gitiles commit info from properties and tags
[15:43:19.375] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:43:19.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:43:19.376] Buildbucket request:
{
"requestId": "8872611832356685456",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872611832356685456",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0bcf45ea3458ba79eb4257afcfd6af954292c9ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0bcf45ea3458ba79eb4257afcfd6af954292c9ce",
"title": "0bcf45ea3458ba79eb4257afcfd6af954292c9ce",
"url": "https://llvm.googlesource.com/llvm-project/+/0bcf45ea3458ba79eb4257afcfd6af954292c9ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69d0bd56ad064df569cd065902fb7036f0311c0a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69d0bd56ad064df569cd065902fb7036f0311c0a",
"title": "69d0bd56ad064df569cd065902fb7036f0311c0a",
"url": "https://llvm.googlesource.com/llvm-project/+/69d0bd56ad064df569cd065902fb7036f0311c0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5dff1ad3a3570f0f5a154590ce43b107dc6c3994"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5dff1ad3a3570f0f5a154590ce43b107dc6c3994",
"title": "5dff1ad3a3570f0f5a154590ce43b107dc6c3994",
"url": "https://llvm.googlesource.com/llvm-project/+/5dff1ad3a3570f0f5a154590ce43b107dc6c3994"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4be22dabc58046ddcab449368132754892242250"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4be22dabc58046ddcab449368132754892242250",
"title": "4be22dabc58046ddcab449368132754892242250",
"url": "https://llvm.googlesource.com/llvm-project/+/4be22dabc58046ddcab449368132754892242250"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "02fbb6a290779af31f24d6fffd104675fc10d986"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@02fbb6a290779af31f24d6fffd104675fc10d986",
"title": "02fbb6a290779af31f24d6fffd104675fc10d986",
"url": "https://llvm.googlesource.com/llvm-project/+/02fbb6a290779af31f24d6fffd104675fc10d986"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ebaaf4d2fbf389ac3f171245e38c7a63812b43b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ebaaf4d2fbf389ac3f171245e38c7a63812b43b8",
"title": "ebaaf4d2fbf389ac3f171245e38c7a63812b43b8",
"url": "https://llvm.googlesource.com/llvm-project/+/ebaaf4d2fbf389ac3f171245e38c7a63812b43b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e10fdb989b8c59a8291f1f6931f3adfd374ad840"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e10fdb989b8c59a8291f1f6931f3adfd374ad840",
"title": "e10fdb989b8c59a8291f1f6931f3adfd374ad840",
"url": "https://llvm.googlesource.com/llvm-project/+/e10fdb989b8c59a8291f1f6931f3adfd374ad840"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "82f5bd68d03c2ef963f5e53843b1c47989dcd5d7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@82f5bd68d03c2ef963f5e53843b1c47989dcd5d7",
"title": "82f5bd68d03c2ef963f5e53843b1c47989dcd5d7",
"url": "https://llvm.googlesource.com/llvm-project/+/82f5bd68d03c2ef963f5e53843b1c47989dcd5d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f3db0cb4d8326c4955472742872cb691d17e76c6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f3db0cb4d8326c4955472742872cb691d17e76c6",
"title": "f3db0cb4d8326c4955472742872cb691d17e76c6",
"url": "https://llvm.googlesource.com/llvm-project/+/f3db0cb4d8326c4955472742872cb691d17e76c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c088b5ffca4c4b81a8fa0e7f006e9391eba1f191"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c088b5ffca4c4b81a8fa0e7f006e9391eba1f191",
"title": "c088b5ffca4c4b81a8fa0e7f006e9391eba1f191",
"url": "https://llvm.googlesource.com/llvm-project/+/c088b5ffca4c4b81a8fa0e7f006e9391eba1f191"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e1171e6a98f9c1a5cd465a47210b2678631a9c3c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e1171e6a98f9c1a5cd465a47210b2678631a9c3c",
"title": "e1171e6a98f9c1a5cd465a47210b2678631a9c3c",
"url": "https://llvm.googlesource.com/llvm-project/+/e1171e6a98f9c1a5cd465a47210b2678631a9c3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3fa34f17e822fbe652e694b7b421ce7108f902df"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3fa34f17e822fbe652e694b7b421ce7108f902df",
"title": "3fa34f17e822fbe652e694b7b421ce7108f902df",
"url": "https://llvm.googlesource.com/llvm-project/+/3fa34f17e822fbe652e694b7b421ce7108f902df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3b5cc2dc6374a5785741aedb28ad80b7e941b70c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3b5cc2dc6374a5785741aedb28ad80b7e941b70c",
"title": "3b5cc2dc6374a5785741aedb28ad80b7e941b70c",
"url": "https://llvm.googlesource.com/llvm-project/+/3b5cc2dc6374a5785741aedb28ad80b7e941b70c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44fbeb3215f31ace95ea2a7e88121920e813db5d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44fbeb3215f31ace95ea2a7e88121920e813db5d",
"title": "44fbeb3215f31ace95ea2a7e88121920e813db5d",
"url": "https://llvm.googlesource.com/llvm-project/+/44fbeb3215f31ace95ea2a7e88121920e813db5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0cb98c721bb540febab0fc0094388480940c49b0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0cb98c721bb540febab0fc0094388480940c49b0",
"title": "0cb98c721bb540febab0fc0094388480940c49b0",
"url": "https://llvm.googlesource.com/llvm-project/+/0cb98c721bb540febab0fc0094388480940c49b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9b68838f61972fadfbe70787befc3abeb2efcb5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9b68838f61972fadfbe70787befc3abeb2efcb5",
"title": "f9b68838f61972fadfbe70787befc3abeb2efcb5",
"url": "https://llvm.googlesource.com/llvm-project/+/f9b68838f61972fadfbe70787befc3abeb2efcb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff616a192bb486915200675d7be33dc042deca24"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff616a192bb486915200675d7be33dc042deca24",
"title": "ff616a192bb486915200675d7be33dc042deca24",
"url": "https://llvm.googlesource.com/llvm-project/+/ff616a192bb486915200675d7be33dc042deca24"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff616a192bb486915200675d7be33dc042deca24",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872611832356685456"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:43:19.852] Scheduled build:
{
"id": "8707181770464225713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-07T15:43:19.435674357Z",
"updateTime": "2025-08-07T15:43:19.435674357Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff616a192bb486915200675d7be33dc042deca24",
"ref": "refs/heads/main"
}
}
}
[15:43:19.852] Task URL: https://cr-buildbucket.appspot.com/build/8707181770464225713
[15:43:19.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:2:0) after 9m13s
[15:43:20.812] Received PubSub notification, asking Buildbucket for the build status
[15:43:20.827] Build status: SCHEDULED
[15:43:30.993] Received PubSub notification, asking Buildbucket for the build status
[15:43:31.052] Build status: STARTED
[15:52:32.909] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:2:0)
[15:52:32.945] Build status: STARTED
[15:52:32.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:5:0) after 3m12s
[15:55:44.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:5:0)
[15:55:45.001] Build status: STARTED
[15:55:45.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:6:0) after 9m4s
[16:04:49.087] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:6:0)
[16:04:49.125] Build status: STARTED
[16:04:49.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:7:0) after 4m13s
[16:09:02.193] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:7:0)
[16:09:02.264] Build status: STARTED
[16:09:02.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:8:0) after 2m19s
[16:11:21.341] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:8:0)
[16:11:21.417] Build status: STARTED
[16:11:21.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:9:0) after 3m18s
[16:14:39.499] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:9:0)
[16:14:39.517] Build status: STARTED
[16:14:39.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:10:0) after 7m16s
[16:21:55.536] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:10:0)
[16:21:55.554] Build status: STARTED
[16:21:55.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:11:0) after 7m46s
[16:29:41.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:11:0)
[16:29:41.723] Build status: STARTED
[16:29:41.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:12:0) after 5m8s
[16:34:49.759] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:12:0)
[16:34:49.780] Build status: STARTED
[16:34:49.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:13:0) after 7m26s
[16:42:15.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:13:0)
[16:42:15.850] Build status: STARTED
[16:42:15.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:14:0) after 9m1s
[16:51:16.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:14:0)
[16:51:16.890] Build status: STARTED
[16:51:16.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:15:0) after 4m56s
[16:56:12.861] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:15:0)
[16:56:12.887] Build status: STARTED
[16:56:12.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:16:0) after 8m23s
[17:04:35.913] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:16:0)
[17:04:35.939] Build status: STARTED
[17:04:35.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:17:0) after 1m14s
[17:05:49.956] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:17:0)
[17:05:49.991] Build status: STARTED
[17:05:49.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:18:0) after 1m11s
[17:07:01.019] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:18:0)
[17:07:01.052] Build status: STARTED
[17:07:01.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:19:0) after 9m28s
[17:16:29.118] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:19:0)
[17:16:29.136] Build status: STARTED
[17:16:29.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:20:0) after 5m24s
[17:21:53.153] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:20:0)
[17:21:53.179] Build status: STARTED
[17:21:53.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:21:0) after 1m40s
[17:23:33.244] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:21:0)
[17:23:33.274] Build status: STARTED
[17:23:33.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:22:0) after 4m36s
[17:28:09.422] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:22:0)
[17:28:09.446] Build status: STARTED
[17:28:09.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8872611832356685456:23:0) after 8m33s
[17:31:20.968] Received PubSub notification, asking Buildbucket for the build status
[17:31:20.986] Build:
{
"id": "8707181770464225713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-07T15:43:19.435674357Z",
"startTime": "2025-08-07T15:43:25.138274666Z",
"endTime": "2025-08-07T17:31:18.589936790Z",
"updateTime": "2025-08-07T17:31:18.589936790Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff616a192bb486915200675d7be33dc042deca24",
"ref": "refs/heads/main"
}
}
}
[17:31:20.986] Invocation finished in 1h48m2.738829836s with status SUCCEEDED