[13:08:04.428] New invocation is queued and will start shortly
[13:08:05.513] Starting the invocation (attempt 1)
[13:08:05.538] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b16fe132c68834a601b29c0eb53c7ec25a3cd627"
[13:08:05.538] Popped gitiles commit info from properties and tags
[13:08:05.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:08:05.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:08:05.538] Buildbucket request:
{
"requestId": "8872983986477938384",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872983986477938384",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b983ce8145622160b65736bbe4b73860d5557b0c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b983ce8145622160b65736bbe4b73860d5557b0c",
"title": "b983ce8145622160b65736bbe4b73860d5557b0c",
"url": "https://llvm.googlesource.com/llvm-project/+/b983ce8145622160b65736bbe4b73860d5557b0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2579ffccc7258830dc7b1635c60ad2a24f7060bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2579ffccc7258830dc7b1635c60ad2a24f7060bd",
"title": "2579ffccc7258830dc7b1635c60ad2a24f7060bd",
"url": "https://llvm.googlesource.com/llvm-project/+/2579ffccc7258830dc7b1635c60ad2a24f7060bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e44a14e9ac4f5bfc6f274a24689377eeba509146"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e44a14e9ac4f5bfc6f274a24689377eeba509146",
"title": "e44a14e9ac4f5bfc6f274a24689377eeba509146",
"url": "https://llvm.googlesource.com/llvm-project/+/e44a14e9ac4f5bfc6f274a24689377eeba509146"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "559d1dff891682ec66d4a987dfa0b9404c7af3e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@559d1dff891682ec66d4a987dfa0b9404c7af3e4",
"title": "559d1dff891682ec66d4a987dfa0b9404c7af3e4",
"url": "https://llvm.googlesource.com/llvm-project/+/559d1dff891682ec66d4a987dfa0b9404c7af3e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b16fe132c68834a601b29c0eb53c7ec25a3cd627"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b16fe132c68834a601b29c0eb53c7ec25a3cd627",
"title": "b16fe132c68834a601b29c0eb53c7ec25a3cd627",
"url": "https://llvm.googlesource.com/llvm-project/+/b16fe132c68834a601b29c0eb53c7ec25a3cd627"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b16fe132c68834a601b29c0eb53c7ec25a3cd627",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872983986477938384"
},
{
"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"
}
}
[13:08:05.973] Scheduled build:
{
"id": "8707553924591796417",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-03T13:08:05.602515397Z",
"updateTime": "2025-08-03T13:08:05.602515397Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b16fe132c68834a601b29c0eb53c7ec25a3cd627",
"ref": "refs/heads/main"
}
}
}
[13:08:05.973] Task URL: https://cr-buildbucket.appspot.com/build/8707553924591796417
[13:08:05.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:2:0) after 2m34s
[13:08:06.975] Received PubSub notification, asking Buildbucket for the build status
[13:08:07.002] Build status: SCHEDULED
[13:10:39.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:2:0)
[13:10:40.066] Build status: SCHEDULED
[13:10:40.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:4:0) after 2m37s
[13:13:17.080] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:4:0)
[13:13:17.102] Build status: SCHEDULED
[13:13:17.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:5:0) after 7m51s
[13:21:08.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:5:0)
[13:21:08.402] Build status: SCHEDULED
[13:21:08.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:6:0) after 2m53s
[13:24:01.427] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:6:0)
[13:24:01.453] Build status: SCHEDULED
[13:24:01.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:7:0) after 5m8s
[13:29:09.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:7:0)
[13:29:09.731] Build status: SCHEDULED
[13:29:09.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:8:0) after 6m3s
[13:30:58.448] Received PubSub notification, asking Buildbucket for the build status
[13:30:58.532] Build status: STARTED
[13:35:12.893] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:8:0)
[13:35:12.917] Build status: STARTED
[13:35:12.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:10:0) after 4m13s
[13:39:25.950] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:10:0)
[13:39:25.972] Build status: STARTED
[13:39:25.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:11:0) after 3m12s
[13:42:38.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:11:0)
[13:42:38.043] Build status: STARTED
[13:42:38.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:12:0) after 1m27s
[13:44:05.064] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:12:0)
[13:44:05.089] Build status: STARTED
[13:44:05.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:13:0) after 9m17s
[13:53:22.115] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:13:0)
[13:53:22.137] Build status: STARTED
[13:53:22.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:14:0) after 4m10s
[13:57:32.150] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:14:0)
[13:57:32.172] Build status: STARTED
[13:57:32.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:15:0) after 7m55s
[14:05:27.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:15:0)
[14:05:27.663] Build status: STARTED
[14:05:27.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:16:0) after 4m42s
[14:10:09.662] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:16:0)
[14:10:09.676] Build status: STARTED
[14:10:09.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:17:0) after 5m54s
[14:16:03.795] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:17:0)
[14:16:03.815] Build status: STARTED
[14:16:03.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:18:0) after 9m28s
[14:25:31.847] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:18:0)
[14:25:31.867] Build status: STARTED
[14:25:31.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:19:0) after 7m40s
[14:33:11.961] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:19:0)
[14:33:12.034] Build status: STARTED
[14:33:12.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:20:0) after 6m30s
[14:39:42.079] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:20:0)
[14:39:42.095] Build status: STARTED
[14:39:42.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:21:0) after 4m20s
[14:44:02.131] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:21:0)
[14:44:02.154] Build status: STARTED
[14:44:02.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:22:0) after 2m25s
[14:46:27.177] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:22:0)
[14:46:27.196] Build status: STARTED
[14:46:27.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:23:0) after 4m0s
[14:50:27.317] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:23:0)
[14:50:27.348] Build status: STARTED
[14:50:27.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:24:0) after 3m31s
[14:53:58.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:24:0)
[14:53:58.384] Build status: STARTED
[14:53:58.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:25:0) after 1m11s
[14:55:09.783] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:25:0)
[14:55:09.858] Build status: STARTED
[14:55:09.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:26:0) after 2m39s
[14:57:49.363] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:26:0)
[14:57:49.446] Build status: STARTED
[14:57:49.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:27:0) after 1m54s
[14:59:43.469] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:27:0)
[14:59:43.484] Build status: STARTED
[14:59:43.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:28:0) after 1m58s
[15:01:41.948] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:28:0)
[15:01:41.969] Build status: STARTED
[15:01:41.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872983986477938384:29:0) after 9m21s
[15:06:09.164] Received PubSub notification, asking Buildbucket for the build status
[15:06:09.185] Build:
{
"id": "8707553924591796417",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-03T13:08:05.602515397Z",
"startTime": "2025-08-03T13:30:58.152620426Z",
"endTime": "2025-08-03T15:06:08.465353106Z",
"updateTime": "2025-08-03T15:06:08.465353106Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b16fe132c68834a601b29c0eb53c7ec25a3cd627",
"ref": "refs/heads/main"
}
}
}
[15:06:09.185] Invocation finished in 1h58m4.76523364s with status SUCCEEDED