[01:42:58.772] New invocation is queued and will start shortly
[01:42:59.992] Starting the invocation (attempt 1)
[01:43:00.029] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a69cddef43f64d5307c0d5f2f01e5176ac05729a"
[01:43:00.029] Popped gitiles commit info from properties and tags
[01:43:00.029] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:43:00.032] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:43:00.032] Buildbucket request:
{
"requestId": "8874023655517623712",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874023655517623712",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "482ec90428017f986edc67644484555a367a624c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@482ec90428017f986edc67644484555a367a624c",
"title": "482ec90428017f986edc67644484555a367a624c",
"url": "https://llvm.googlesource.com/llvm-project/+/482ec90428017f986edc67644484555a367a624c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dbc41dd5d827a3e13625a66fd2bfa83a8a4dfe83"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dbc41dd5d827a3e13625a66fd2bfa83a8a4dfe83",
"title": "dbc41dd5d827a3e13625a66fd2bfa83a8a4dfe83",
"url": "https://llvm.googlesource.com/llvm-project/+/dbc41dd5d827a3e13625a66fd2bfa83a8a4dfe83"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bbbe69f5f3983e919ebceb5f702b248aff495a3a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bbbe69f5f3983e919ebceb5f702b248aff495a3a",
"title": "bbbe69f5f3983e919ebceb5f702b248aff495a3a",
"url": "https://llvm.googlesource.com/llvm-project/+/bbbe69f5f3983e919ebceb5f702b248aff495a3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7dc9b433673e28f671894bd22c65f406ba9bea6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7dc9b433673e28f671894bd22c65f406ba9bea6f",
"title": "7dc9b433673e28f671894bd22c65f406ba9bea6f",
"url": "https://llvm.googlesource.com/llvm-project/+/7dc9b433673e28f671894bd22c65f406ba9bea6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0dd22fab19df2c9370fc2e90bcf57eb0cf25bed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0dd22fab19df2c9370fc2e90bcf57eb0cf25bed",
"title": "e0dd22fab19df2c9370fc2e90bcf57eb0cf25bed",
"url": "https://llvm.googlesource.com/llvm-project/+/e0dd22fab19df2c9370fc2e90bcf57eb0cf25bed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "726502d668d12d917411d48d0b2210f8592b23a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@726502d668d12d917411d48d0b2210f8592b23a9",
"title": "726502d668d12d917411d48d0b2210f8592b23a9",
"url": "https://llvm.googlesource.com/llvm-project/+/726502d668d12d917411d48d0b2210f8592b23a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c26858f1a8bc5796c493f4f720552edbcb09fb4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c26858f1a8bc5796c493f4f720552edbcb09fb4",
"title": "8c26858f1a8bc5796c493f4f720552edbcb09fb4",
"url": "https://llvm.googlesource.com/llvm-project/+/8c26858f1a8bc5796c493f4f720552edbcb09fb4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "471e59b858b1d2ee844cb527522e60ed03a1a1dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@471e59b858b1d2ee844cb527522e60ed03a1a1dc",
"title": "471e59b858b1d2ee844cb527522e60ed03a1a1dc",
"url": "https://llvm.googlesource.com/llvm-project/+/471e59b858b1d2ee844cb527522e60ed03a1a1dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f410b491e55f3b91587da926a7a6fee99722df3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f410b491e55f3b91587da926a7a6fee99722df3",
"title": "8f410b491e55f3b91587da926a7a6fee99722df3",
"url": "https://llvm.googlesource.com/llvm-project/+/8f410b491e55f3b91587da926a7a6fee99722df3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c4fa11dd871ba747867d2e707d643664868837e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c4fa11dd871ba747867d2e707d643664868837e",
"title": "8c4fa11dd871ba747867d2e707d643664868837e",
"url": "https://llvm.googlesource.com/llvm-project/+/8c4fa11dd871ba747867d2e707d643664868837e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "efffa42f593739ea7d80a5be301b6f235e44f35a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@efffa42f593739ea7d80a5be301b6f235e44f35a",
"title": "efffa42f593739ea7d80a5be301b6f235e44f35a",
"url": "https://llvm.googlesource.com/llvm-project/+/efffa42f593739ea7d80a5be301b6f235e44f35a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a69cddef43f64d5307c0d5f2f01e5176ac05729a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a69cddef43f64d5307c0d5f2f01e5176ac05729a",
"title": "a69cddef43f64d5307c0d5f2f01e5176ac05729a",
"url": "https://llvm.googlesource.com/llvm-project/+/a69cddef43f64d5307c0d5f2f01e5176ac05729a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a69cddef43f64d5307c0d5f2f01e5176ac05729a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874023655517623712"
},
{
"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"
}
}
[01:43:00.897] Scheduled build:
{
"id": "8708593593306665073",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-23T01:43:00.251791035Z",
"updateTime": "2025-07-23T01:43:00.251791035Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a69cddef43f64d5307c0d5f2f01e5176ac05729a",
"ref": "refs/heads/main"
}
}
}
[01:43:00.897] Task URL: https://cr-buildbucket.appspot.com/build/8708593593306665073
[01:43:00.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:2:0) after 5m38s
[01:43:20.480] Received PubSub notification, asking Buildbucket for the build status
[01:43:20.521] Build status: SCHEDULED
[01:48:39.273] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:2:0)
[01:48:39.298] Build status: SCHEDULED
[01:48:39.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:4:0) after 8m56s
[01:57:35.316] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:4:0)
[01:57:35.338] Build status: SCHEDULED
[01:57:35.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:5:0) after 2m5s
[01:59:40.796] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:5:0)
[01:59:40.824] Build status: SCHEDULED
[01:59:40.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:6:0) after 3m27s
[01:59:58.455] Received PubSub notification, asking Buildbucket for the build status
[01:59:58.531] Build status: STARTED
[02:03:07.839] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:6:0)
[02:03:07.904] Build status: STARTED
[02:03:07.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:8:0) after 8m33s
[02:11:40.889] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:8:0)
[02:11:40.932] Build status: STARTED
[02:11:40.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:9:0) after 5m1s
[02:16:42.110] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:9:0)
[02:16:42.141] Build status: STARTED
[02:16:42.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:10:0) after 8m40s
[02:25:22.171] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:10:0)
[02:25:22.242] Build status: STARTED
[02:25:22.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:11:0) after 7m35s
[02:32:57.262] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:11:0)
[02:32:57.349] Build status: STARTED
[02:32:57.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:12:0) after 6m29s
[02:39:26.369] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:12:0)
[02:39:26.403] Build status: STARTED
[02:39:26.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:13:0) after 6m57s
[02:46:23.525] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:13:0)
[02:46:23.648] Build status: STARTED
[02:46:23.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:14:0) after 2m23s
[02:48:46.741] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:14:0)
[02:48:46.818] Build status: STARTED
[02:48:46.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:15:0) after 2m0s
[02:50:47.046] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:15:0)
[02:50:47.066] Build status: STARTED
[02:50:47.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:16:0) after 2m45s
[02:53:32.100] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:16:0)
[02:53:32.129] Build status: STARTED
[02:53:32.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:17:0) after 4m57s
[02:58:29.178] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:17:0)
[02:58:29.206] Build status: STARTED
[02:58:29.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:18:0) after 2m56s
[03:01:25.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:18:0)
[03:01:25.296] Build status: STARTED
[03:01:25.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874023655517623712:19:0) after 8m49s
[03:09:36.344] Received PubSub notification, asking Buildbucket for the build status
[03:09:36.371] Build:
{
"id": "8708593593306665073",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-23T01:43:00.251791035Z",
"startTime": "2025-07-23T01:59:58.095776467Z",
"endTime": "2025-07-23T03:09:35.914688873Z",
"updateTime": "2025-07-23T03:09:35.914688873Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a69cddef43f64d5307c0d5f2f01e5176ac05729a",
"ref": "refs/heads/main"
}
}
}
[03:09:36.371] Invocation finished in 1h26m37.611869723s with status SUCCEEDED