[11:40:41.453] New invocation is queued and will start shortly
[11:40:42.699] Starting the invocation (attempt 1)
[11:40:42.727] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d3bbdc7bdea651658c4964346d34ac470742d90d"
[11:40:42.727] Popped gitiles commit info from properties and tags
[11:40:42.727] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:40:42.727] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:40:42.727] Buildbucket request:
{
"requestId": "8871992917509845536",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871992917509845536",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d4f3171fa97a8c74c57fdbac2f609344b9a3f2d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d4f3171fa97a8c74c57fdbac2f609344b9a3f2d",
"title": "8d4f3171fa97a8c74c57fdbac2f609344b9a3f2d",
"url": "https://llvm.googlesource.com/llvm-project/+/8d4f3171fa97a8c74c57fdbac2f609344b9a3f2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "186176de459bd53e925ddc9c37500885551e1966"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@186176de459bd53e925ddc9c37500885551e1966",
"title": "186176de459bd53e925ddc9c37500885551e1966",
"url": "https://llvm.googlesource.com/llvm-project/+/186176de459bd53e925ddc9c37500885551e1966"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d15b7a83a7e0b8a73763e24ad162a544a68ae74d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d15b7a83a7e0b8a73763e24ad162a544a68ae74d",
"title": "d15b7a83a7e0b8a73763e24ad162a544a68ae74d",
"url": "https://llvm.googlesource.com/llvm-project/+/d15b7a83a7e0b8a73763e24ad162a544a68ae74d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5b36eb3a4919137f5594c6be564819dd60f5acf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5b36eb3a4919137f5594c6be564819dd60f5acf",
"title": "f5b36eb3a4919137f5594c6be564819dd60f5acf",
"url": "https://llvm.googlesource.com/llvm-project/+/f5b36eb3a4919137f5594c6be564819dd60f5acf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3bc3b4cf5fe96afed668f24d741e509bae55cdc6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3bc3b4cf5fe96afed668f24d741e509bae55cdc6",
"title": "3bc3b4cf5fe96afed668f24d741e509bae55cdc6",
"url": "https://llvm.googlesource.com/llvm-project/+/3bc3b4cf5fe96afed668f24d741e509bae55cdc6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d3bbdc7bdea651658c4964346d34ac470742d90d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d3bbdc7bdea651658c4964346d34ac470742d90d",
"title": "d3bbdc7bdea651658c4964346d34ac470742d90d",
"url": "https://llvm.googlesource.com/llvm-project/+/d3bbdc7bdea651658c4964346d34ac470742d90d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d3bbdc7bdea651658c4964346d34ac470742d90d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871992917509845536"
},
{
"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"
}
}
[11:40:43.272] Scheduled build:
{
"id": "8706562855445501729",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T11:40:42.792150335Z",
"updateTime": "2025-08-14T11:40:42.792150335Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d3bbdc7bdea651658c4964346d34ac470742d90d",
"ref": "refs/heads/main"
}
}
}
[11:40:43.272] Task URL: https://cr-buildbucket.appspot.com/build/8706562855445501729
[11:40:43.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:2:0) after 5m26s
[11:40:44.093] Received PubSub notification, asking Buildbucket for the build status
[11:40:44.113] Build status: SCHEDULED
[11:41:30.128] Received PubSub notification, asking Buildbucket for the build status
[11:41:30.163] Build status: STARTED
[11:46:09.500] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:2:0)
[11:46:09.516] Build status: STARTED
[11:46:09.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:5:0) after 2m7s
[11:48:16.843] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:5:0)
[11:48:16.874] Build status: STARTED
[11:48:16.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:6:0) after 1m31s
[11:49:47.881] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:6:0)
[11:49:47.912] Build status: STARTED
[11:49:47.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:7:0) after 2m17s
[11:52:04.989] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:7:0)
[11:52:05.005] Build status: STARTED
[11:52:05.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:8:0) after 6m42s
[11:58:47.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:8:0)
[11:58:47.051] Build status: STARTED
[11:58:47.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:9:0) after 8m31s
[12:07:18.122] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:9:0)
[12:07:18.155] Build status: STARTED
[12:07:18.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:10:0) after 7m7s
[12:14:25.174] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:10:0)
[12:14:25.190] Build status: STARTED
[12:14:25.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:11:0) after 9m46s
[12:24:11.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:11:0)
[12:24:11.345] Build status: STARTED
[12:24:11.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:12:0) after 6m5s
[12:30:16.372] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:12:0)
[12:30:16.392] Build status: STARTED
[12:30:16.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:13:0) after 2m15s
[12:32:31.419] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:13:0)
[12:32:31.462] Build status: STARTED
[12:32:31.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:14:0) after 4m4s
[12:36:35.522] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:14:0)
[12:36:35.540] Build status: STARTED
[12:36:35.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:15:0) after 3m25s
[12:40:00.575] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:15:0)
[12:40:00.602] Build status: STARTED
[12:40:00.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:16:0) after 1m40s
[12:41:40.668] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:16:0)
[12:41:40.687] Build status: STARTED
[12:41:40.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:17:0) after 9m11s
[12:50:51.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:17:0)
[12:50:51.734] Build status: STARTED
[12:50:51.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:18:0) after 5m28s
[12:56:19.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:18:0)
[12:56:19.773] Build status: STARTED
[12:56:19.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:19:0) after 3m21s
[12:59:40.753] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:19:0)
[12:59:40.804] Build status: STARTED
[12:59:40.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:20:0) after 4m14s
[13:03:54.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:20:0)
[13:03:55.003] Build status: STARTED
[13:03:55.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:21:0) after 4m9s
[13:08:04.096] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:21:0)
[13:08:04.124] Build status: STARTED
[13:08:04.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:22:0) after 7m39s
[13:15:44.216] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:22:0)
[13:15:44.236] Build status: STARTED
[13:15:44.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871992917509845536:23:0) after 8m1s
[13:15:49.889] Received PubSub notification, asking Buildbucket for the build status
[13:15:49.907] Build:
{
"id": "8706562855445501729",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T11:40:42.792150335Z",
"startTime": "2025-08-14T11:41:29.872753872Z",
"endTime": "2025-08-14T13:15:49.533915675Z",
"updateTime": "2025-08-14T13:15:49.533915675Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d3bbdc7bdea651658c4964346d34ac470742d90d",
"ref": "refs/heads/main"
}
}
}
[13:15:49.908] Invocation finished in 1h35m8.467833615s with status SUCCEEDED