[18:17:24.634] New invocation is queued and will start shortly
[18:17:25.798] Starting the invocation (attempt 1)
[18:17:25.828] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/fd59fd563f342c8900b0d6ff5039741cb263b6ed"
[18:17:25.828] Popped gitiles commit info from properties and tags
[18:17:25.829] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:25.829] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:25.830] Buildbucket request:
{
"requestId": "8868978258167018752",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868978258167018752",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba5ca37f40b82e287a3e0469fb0f0ea48b651aca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba5ca37f40b82e287a3e0469fb0f0ea48b651aca",
"title": "ba5ca37f40b82e287a3e0469fb0f0ea48b651aca",
"url": "https://llvm.googlesource.com/llvm-project/+/ba5ca37f40b82e287a3e0469fb0f0ea48b651aca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "371048ef220719a5aa89ba5cf05cc212e659af40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@371048ef220719a5aa89ba5cf05cc212e659af40",
"title": "371048ef220719a5aa89ba5cf05cc212e659af40",
"url": "https://llvm.googlesource.com/llvm-project/+/371048ef220719a5aa89ba5cf05cc212e659af40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d0c0986387b333589951c29e2b5205d08c67c668"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d0c0986387b333589951c29e2b5205d08c67c668",
"title": "d0c0986387b333589951c29e2b5205d08c67c668",
"url": "https://llvm.googlesource.com/llvm-project/+/d0c0986387b333589951c29e2b5205d08c67c668"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55e6b3260dcb2b2131317516bf63cc81bd9f5bed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55e6b3260dcb2b2131317516bf63cc81bd9f5bed",
"title": "55e6b3260dcb2b2131317516bf63cc81bd9f5bed",
"url": "https://llvm.googlesource.com/llvm-project/+/55e6b3260dcb2b2131317516bf63cc81bd9f5bed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7bc91f3580836c13cfcf511147585a5f2f00a7f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7bc91f3580836c13cfcf511147585a5f2f00a7f5",
"title": "7bc91f3580836c13cfcf511147585a5f2f00a7f5",
"url": "https://llvm.googlesource.com/llvm-project/+/7bc91f3580836c13cfcf511147585a5f2f00a7f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "40f2da5c04042dcf6ae8dfc757d31a32da7f329e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@40f2da5c04042dcf6ae8dfc757d31a32da7f329e",
"title": "40f2da5c04042dcf6ae8dfc757d31a32da7f329e",
"url": "https://llvm.googlesource.com/llvm-project/+/40f2da5c04042dcf6ae8dfc757d31a32da7f329e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f209d63b042e3b3455b67ecb08908135dd9d31fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f209d63b042e3b3455b67ecb08908135dd9d31fe",
"title": "f209d63b042e3b3455b67ecb08908135dd9d31fe",
"url": "https://llvm.googlesource.com/llvm-project/+/f209d63b042e3b3455b67ecb08908135dd9d31fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "198ea2332584bf838a893522b870e1bf033ce7a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@198ea2332584bf838a893522b870e1bf033ce7a4",
"title": "198ea2332584bf838a893522b870e1bf033ce7a4",
"url": "https://llvm.googlesource.com/llvm-project/+/198ea2332584bf838a893522b870e1bf033ce7a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8efe1c64746e832bc3313ec2f6a23f09f2d2dd9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8efe1c64746e832bc3313ec2f6a23f09f2d2dd9",
"title": "b8efe1c64746e832bc3313ec2f6a23f09f2d2dd9",
"url": "https://llvm.googlesource.com/llvm-project/+/b8efe1c64746e832bc3313ec2f6a23f09f2d2dd9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b76dc2b9ba7d402d1c9909b87322f2b0008ce3a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b76dc2b9ba7d402d1c9909b87322f2b0008ce3a6",
"title": "b76dc2b9ba7d402d1c9909b87322f2b0008ce3a6",
"url": "https://llvm.googlesource.com/llvm-project/+/b76dc2b9ba7d402d1c9909b87322f2b0008ce3a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0648c5183f3202060862cd6cba8e6f2395052929"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0648c5183f3202060862cd6cba8e6f2395052929",
"title": "0648c5183f3202060862cd6cba8e6f2395052929",
"url": "https://llvm.googlesource.com/llvm-project/+/0648c5183f3202060862cd6cba8e6f2395052929"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e9edb583400ffc647622445459d700d0ad61b3d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e9edb583400ffc647622445459d700d0ad61b3d",
"title": "9e9edb583400ffc647622445459d700d0ad61b3d",
"url": "https://llvm.googlesource.com/llvm-project/+/9e9edb583400ffc647622445459d700d0ad61b3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c4ab4fdefcbd34106163899d7e2914246328616"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c4ab4fdefcbd34106163899d7e2914246328616",
"title": "3c4ab4fdefcbd34106163899d7e2914246328616",
"url": "https://llvm.googlesource.com/llvm-project/+/3c4ab4fdefcbd34106163899d7e2914246328616"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "181979822743ddaf4c197e1587c0c89b5f4240a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@181979822743ddaf4c197e1587c0c89b5f4240a4",
"title": "181979822743ddaf4c197e1587c0c89b5f4240a4",
"url": "https://llvm.googlesource.com/llvm-project/+/181979822743ddaf4c197e1587c0c89b5f4240a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f854009307d3f3750d3358510ef632571683acb5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f854009307d3f3750d3358510ef632571683acb5",
"title": "f854009307d3f3750d3358510ef632571683acb5",
"url": "https://llvm.googlesource.com/llvm-project/+/f854009307d3f3750d3358510ef632571683acb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46fd8d0db2f7f7361823efae067edddb6acc237c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46fd8d0db2f7f7361823efae067edddb6acc237c",
"title": "46fd8d0db2f7f7361823efae067edddb6acc237c",
"url": "https://llvm.googlesource.com/llvm-project/+/46fd8d0db2f7f7361823efae067edddb6acc237c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd59fd563f342c8900b0d6ff5039741cb263b6ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd59fd563f342c8900b0d6ff5039741cb263b6ed",
"title": "fd59fd563f342c8900b0d6ff5039741cb263b6ed",
"url": "https://llvm.googlesource.com/llvm-project/+/fd59fd563f342c8900b0d6ff5039741cb263b6ed"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd59fd563f342c8900b0d6ff5039741cb263b6ed",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868978258167018752"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:17:26.308] Scheduled build:
{
"id": "8703548196165129553",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T18:17:25.921723339Z",
"updateTime": "2025-09-16T18:17:25.921723339Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd59fd563f342c8900b0d6ff5039741cb263b6ed",
"ref": "refs/heads/main"
}
}
}
[18:17:26.308] Task URL: https://cr-buildbucket.appspot.com/build/8703548196165129553
[18:17:26.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:2:0) after 2m59s
[18:17:27.347] Received PubSub notification, asking Buildbucket for the build status
[18:17:27.400] Build status: SCHEDULED
[18:19:14.337] Received PubSub notification, asking Buildbucket for the build status
[18:19:14.354] Build status: STARTED
[18:20:25.324] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:2:0)
[18:20:25.365] Build status: STARTED
[18:20:25.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:5:0) after 5m14s
[18:25:39.425] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:5:0)
[18:25:39.470] Build status: STARTED
[18:25:39.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:6:0) after 3m41s
[18:29:20.538] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:6:0)
[18:29:20.564] Build status: STARTED
[18:29:20.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:7:0) after 7m17s
[18:36:37.681] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:7:0)
[18:36:37.732] Build status: STARTED
[18:36:37.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:8:0) after 2m36s
[18:39:13.848] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:8:0)
[18:39:13.894] Build status: STARTED
[18:39:13.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:9:0) after 1m1s
[18:40:14.955] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:9:0)
[18:40:14.984] Build status: STARTED
[18:40:14.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:10:0) after 1m20s
[18:41:35.275] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:10:0)
[18:41:35.327] Build status: STARTED
[18:41:35.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:11:0) after 7m59s
[18:49:34.363] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:11:0)
[18:49:34.384] Build status: STARTED
[18:49:34.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:12:0) after 3m49s
[18:53:23.459] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:12:0)
[18:53:23.490] Build status: STARTED
[18:53:23.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:13:0) after 1m7s
[18:54:30.509] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:13:0)
[18:54:30.527] Build status: STARTED
[18:54:30.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:14:0) after 8m23s
[19:02:53.552] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:14:0)
[19:02:53.570] Build status: STARTED
[19:02:53.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:15:0) after 7m37s
[19:10:30.714] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:15:0)
[19:10:30.731] Build status: STARTED
[19:10:30.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:16:0) after 7m39s
[19:18:09.852] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:16:0)
[19:18:09.890] Build status: STARTED
[19:18:09.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:17:0) after 5m32s
[19:23:41.928] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:17:0)
[19:23:41.945] Build status: STARTED
[19:23:41.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:18:0) after 9m19s
[19:33:01.014] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:18:0)
[19:33:01.116] Build status: STARTED
[19:33:01.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8868978258167018752:19:0) after 8m13s
[19:38:54.906] Received PubSub notification, asking Buildbucket for the build status
[19:38:54.981] Build:
{
"id": "8703548196165129553",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T18:17:25.921723339Z",
"startTime": "2025-09-16T18:19:13.975863261Z",
"endTime": "2025-09-16T19:38:54.651774974Z",
"updateTime": "2025-09-16T19:38:54.651774974Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd59fd563f342c8900b0d6ff5039741cb263b6ed",
"ref": "refs/heads/main"
}
}
}
[19:38:54.981] Invocation finished in 1h21m30.352639883s with status SUCCEEDED