[22:31:19.286] New invocation is queued and will start shortly
[22:31:20.361] Starting the invocation (attempt 1)
[22:31:20.390] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/fc4df2c9173a110102005af937a26df7f29d24e1"
[22:31:20.390] Popped gitiles commit info from properties and tags
[22:31:20.390] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:31:20.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:31:20.390] Buildbucket request:
{
"requestId": "8871951983371045328",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871951983371045328",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e63d704e8f8bbceffeb19ffd62e0b5ed926dbe6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e63d704e8f8bbceffeb19ffd62e0b5ed926dbe6",
"title": "4e63d704e8f8bbceffeb19ffd62e0b5ed926dbe6",
"url": "https://llvm.googlesource.com/llvm-project/+/4e63d704e8f8bbceffeb19ffd62e0b5ed926dbe6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b989c7c2e099211b549b2866cc4e6c6775775510"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b989c7c2e099211b549b2866cc4e6c6775775510",
"title": "b989c7c2e099211b549b2866cc4e6c6775775510",
"url": "https://llvm.googlesource.com/llvm-project/+/b989c7c2e099211b549b2866cc4e6c6775775510"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "defbbf0129d5c1ac360c6ffd9eaa2f07ab07d622"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@defbbf0129d5c1ac360c6ffd9eaa2f07ab07d622",
"title": "defbbf0129d5c1ac360c6ffd9eaa2f07ab07d622",
"url": "https://llvm.googlesource.com/llvm-project/+/defbbf0129d5c1ac360c6ffd9eaa2f07ab07d622"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cb2f0d0a5f14c183e7182aba0f0e54a518de9e3f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cb2f0d0a5f14c183e7182aba0f0e54a518de9e3f",
"title": "cb2f0d0a5f14c183e7182aba0f0e54a518de9e3f",
"url": "https://llvm.googlesource.com/llvm-project/+/cb2f0d0a5f14c183e7182aba0f0e54a518de9e3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df15c0d716fa0d84104b05937854becacbda6629"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df15c0d716fa0d84104b05937854becacbda6629",
"title": "df15c0d716fa0d84104b05937854becacbda6629",
"url": "https://llvm.googlesource.com/llvm-project/+/df15c0d716fa0d84104b05937854becacbda6629"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a1529cd85a9f99a263de72e16ed2f7567c519456"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a1529cd85a9f99a263de72e16ed2f7567c519456",
"title": "a1529cd85a9f99a263de72e16ed2f7567c519456",
"url": "https://llvm.googlesource.com/llvm-project/+/a1529cd85a9f99a263de72e16ed2f7567c519456"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "57c1e01e484019084cfa975a4f41643d05ae327f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@57c1e01e484019084cfa975a4f41643d05ae327f",
"title": "57c1e01e484019084cfa975a4f41643d05ae327f",
"url": "https://llvm.googlesource.com/llvm-project/+/57c1e01e484019084cfa975a4f41643d05ae327f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fc4df2c9173a110102005af937a26df7f29d24e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fc4df2c9173a110102005af937a26df7f29d24e1",
"title": "fc4df2c9173a110102005af937a26df7f29d24e1",
"url": "https://llvm.googlesource.com/llvm-project/+/fc4df2c9173a110102005af937a26df7f29d24e1"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fc4df2c9173a110102005af937a26df7f29d24e1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871951983371045328"
},
{
"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"
}
}
[22:31:20.789] Scheduled build:
{
"id": "8706521921482931089",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T22:31:20.461895731Z",
"updateTime": "2025-08-14T22:31:20.461895731Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fc4df2c9173a110102005af937a26df7f29d24e1",
"ref": "refs/heads/main"
}
}
}
[22:31:20.789] Task URL: https://cr-buildbucket.appspot.com/build/8706521921482931089
[22:31:20.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:2:0) after 6m9s
[22:31:21.578] Received PubSub notification, asking Buildbucket for the build status
[22:31:21.605] Build status: SCHEDULED
[22:31:25.999] Received PubSub notification, asking Buildbucket for the build status
[22:31:26.024] Build status: STARTED
[22:37:29.852] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:2:0)
[22:37:29.872] Build status: STARTED
[22:37:29.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:5:0) after 5m28s
[22:42:57.936] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:5:0)
[22:42:57.979] Build status: STARTED
[22:42:57.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:6:0) after 7m52s
[22:50:49.996] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:6:0)
[22:50:50.022] Build status: STARTED
[22:50:50.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:7:0) after 1m17s
[22:52:07.036] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:7:0)
[22:52:07.065] Build status: STARTED
[22:52:07.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:8:0) after 5m10s
[22:57:17.128] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:8:0)
[22:57:17.145] Build status: STARTED
[22:57:17.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:9:0) after 7m9s
[23:04:26.160] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:9:0)
[23:04:26.179] Build status: STARTED
[23:04:26.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:10:0) after 9m51s
[23:14:17.264] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:10:0)
[23:14:17.281] Build status: STARTED
[23:14:17.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:11:0) after 4m35s
[23:18:52.340] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:11:0)
[23:18:52.366] Build status: STARTED
[23:18:52.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:12:0) after 5m54s
[23:24:46.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:12:0)
[23:24:46.455] Build status: STARTED
[23:24:46.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:13:0) after 4m51s
[23:29:37.644] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:13:0)
[23:29:37.665] Build status: STARTED
[23:29:37.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:14:0) after 7m17s
[23:36:54.681] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:14:0)
[23:36:54.699] Build status: STARTED
[23:36:54.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:15:0) after 7m22s
[23:44:16.775] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:15:0)
[23:44:16.801] Build status: STARTED
[23:44:16.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:16:0) after 5m35s
[23:49:51.875] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:16:0)
[23:49:51.896] Build status: STARTED
[23:49:51.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:17:0) after 8m47s
[23:58:38.913] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:17:0)
[23:58:38.971] Build status: STARTED
[23:58:38.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:18:0) after 3m38s
[00:02:17.081] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:18:0)
[00:02:17.119] Build status: STARTED
[00:02:17.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:19:0) after 3m39s
[00:05:56.240] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:19:0)
[00:05:56.260] Build status: STARTED
[00:05:56.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8871951983371045328:20:0) after 2m54s
[00:06:20.848] Received PubSub notification, asking Buildbucket for the build status
[00:06:20.866] Build:
{
"id": "8706521921482931089",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T22:31:20.461895731Z",
"startTime": "2025-08-14T22:31:25.745321737Z",
"endTime": "2025-08-15T00:06:20.515953105Z",
"updateTime": "2025-08-15T00:06:20.515953105Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fc4df2c9173a110102005af937a26df7f29d24e1",
"ref": "refs/heads/main"
}
}
}
[00:06:20.866] Invocation finished in 1h35m1.588336202s with status SUCCEEDED