[20:45:58.304] New invocation is queued and will start shortly
[20:45:59.454] Starting the invocation (attempt 1)
[20:45:59.476] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd"
[20:45:59.476] Popped gitiles commit info from properties and tags
[20:45:59.476] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:45:59.476] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:45:59.476] Buildbucket request:
{
"requestId": "8863351899592425184",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863351899592425184",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69b4190d5f1b483524f2f539f373960ef8de8d84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69b4190d5f1b483524f2f539f373960ef8de8d84",
"title": "69b4190d5f1b483524f2f539f373960ef8de8d84",
"url": "https://llvm.googlesource.com/llvm-project/+/69b4190d5f1b483524f2f539f373960ef8de8d84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "21e0b56d7afc2f1af0ad5b728fcc039bfe1d37ff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@21e0b56d7afc2f1af0ad5b728fcc039bfe1d37ff",
"title": "21e0b56d7afc2f1af0ad5b728fcc039bfe1d37ff",
"url": "https://llvm.googlesource.com/llvm-project/+/21e0b56d7afc2f1af0ad5b728fcc039bfe1d37ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "320c18a066b29e90ab5f3ef33b6c510f28edeb80"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@320c18a066b29e90ab5f3ef33b6c510f28edeb80",
"title": "320c18a066b29e90ab5f3ef33b6c510f28edeb80",
"url": "https://llvm.googlesource.com/llvm-project/+/320c18a066b29e90ab5f3ef33b6c510f28edeb80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b32c434426a181590234f65f2e32f43735bf5b5a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b32c434426a181590234f65f2e32f43735bf5b5a",
"title": "b32c434426a181590234f65f2e32f43735bf5b5a",
"url": "https://llvm.googlesource.com/llvm-project/+/b32c434426a181590234f65f2e32f43735bf5b5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "557a6b826b865cd1797ae421f59f286609b94e59"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@557a6b826b865cd1797ae421f59f286609b94e59",
"title": "557a6b826b865cd1797ae421f59f286609b94e59",
"url": "https://llvm.googlesource.com/llvm-project/+/557a6b826b865cd1797ae421f59f286609b94e59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bac8d01a4da14802ec03907d094f3bbc68f6a5cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bac8d01a4da14802ec03907d094f3bbc68f6a5cc",
"title": "bac8d01a4da14802ec03907d094f3bbc68f6a5cc",
"url": "https://llvm.googlesource.com/llvm-project/+/bac8d01a4da14802ec03907d094f3bbc68f6a5cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3fb374256b2fcd3dc091612c6c18a6ad6b6bf138"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3fb374256b2fcd3dc091612c6c18a6ad6b6bf138",
"title": "3fb374256b2fcd3dc091612c6c18a6ad6b6bf138",
"url": "https://llvm.googlesource.com/llvm-project/+/3fb374256b2fcd3dc091612c6c18a6ad6b6bf138"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd",
"title": "4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd",
"url": "https://llvm.googlesource.com/llvm-project/+/4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863351899592425184"
},
{
"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"
}
}
[20:45:59.988] Scheduled build:
{
"id": "8697921837660194369",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-17T20:45:59.522143314Z",
"updateTime": "2025-11-17T20:45:59.522143314Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd",
"ref": "refs/heads/main"
}
}
}
[20:45:59.988] Task URL: https://cr-buildbucket.appspot.com/build/8697921837660194369
[20:45:59.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:2:0) after 5m17s
[20:46:04.166] Received PubSub notification, asking Buildbucket for the build status
[20:46:04.191] Build status: STARTED
[20:46:05.787] Received PubSub notification, asking Buildbucket for the build status
[20:46:05.809] Build status: STARTED
[20:51:17.055] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:2:0)
[20:51:17.146] Build status: STARTED
[20:51:17.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:5:0) after 7m46s
[20:59:03.159] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:5:0)
[20:59:03.180] Build status: STARTED
[20:59:03.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:6:0) after 5m36s
[21:04:39.247] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:6:0)
[21:04:39.265] Build status: STARTED
[21:04:39.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:7:0) after 9m31s
[21:14:10.330] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:7:0)
[21:14:10.352] Build status: STARTED
[21:14:10.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:8:0) after 9m58s
[21:24:08.379] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:8:0)
[21:24:08.398] Build status: STARTED
[21:24:08.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:9:0) after 7m5s
[21:31:13.507] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:9:0)
[21:31:13.541] Build status: STARTED
[21:31:13.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:10:0) after 1m33s
[21:32:46.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:10:0)
[21:32:46.598] Build status: STARTED
[21:32:46.598] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:11:0) after 1m45s
[21:34:31.846] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:11:0)
[21:34:31.875] Build status: STARTED
[21:34:31.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:12:0) after 4m47s
[21:39:18.940] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:12:0)
[21:39:18.952] Build status: STARTED
[21:39:18.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:13:0) after 6m54s
[21:46:13.058] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:13:0)
[21:46:13.083] Build status: STARTED
[21:46:13.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:14:0) after 2m5s
[21:48:18.175] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:14:0)
[21:48:18.192] Build status: STARTED
[21:48:18.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:15:0) after 5m56s
[21:54:14.371] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:15:0)
[21:54:14.404] Build status: STARTED
[21:54:14.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:16:0) after 3m41s
[21:57:55.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:16:0)
[21:57:55.484] Build status: STARTED
[21:57:55.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:17:0) after 8m1s
[22:05:56.494] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:17:0)
[22:05:56.507] Build status: STARTED
[22:05:56.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863351899592425184:18:0) after 4m18s
[22:06:06.040] Received PubSub notification, asking Buildbucket for the build status
[22:06:06.054] Build:
{
"id": "8697921837660194369",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-17T20:45:59.522143314Z",
"startTime": "2025-11-17T20:46:02.565625448Z",
"endTime": "2025-11-17T22:06:05.787921283Z",
"updateTime": "2025-11-17T22:06:05.787921283Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4bec74a9fb82b70db0c1acfc3d1d92d8003d51fd",
"ref": "refs/heads/main"
}
}
}
[22:06:06.054] Invocation finished in 1h20m7.758179813s with status FAILED