[08:46:28.226] New invocation is queued and will start shortly
[08:46:29.330] Starting the invocation (attempt 1)
[08:46:29.359] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/aa71344acdb1a861c1d74345a3fc80aef48bb4b3"
[08:46:29.359] Popped gitiles commit info from properties and tags
[08:46:29.359] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:46:29.359] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:46:29.360] Buildbucket request:
{
"requestId": "8878345666156438096",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8878345666156438096",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1e5f7f64b0c1a816a460f02af9bd9a65f79184c3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1e5f7f64b0c1a816a460f02af9bd9a65f79184c3",
"title": "1e5f7f64b0c1a816a460f02af9bd9a65f79184c3",
"url": "https://llvm.googlesource.com/llvm-project/+/1e5f7f64b0c1a816a460f02af9bd9a65f79184c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9d5e1449f7902329cdf448a1d238529836989582"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9d5e1449f7902329cdf448a1d238529836989582",
"title": "9d5e1449f7902329cdf448a1d238529836989582",
"url": "https://llvm.googlesource.com/llvm-project/+/9d5e1449f7902329cdf448a1d238529836989582"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "100a1d0c4caad0d0f2ec26b07d3cc73f59b9a9a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@100a1d0c4caad0d0f2ec26b07d3cc73f59b9a9a8",
"title": "100a1d0c4caad0d0f2ec26b07d3cc73f59b9a9a8",
"url": "https://llvm.googlesource.com/llvm-project/+/100a1d0c4caad0d0f2ec26b07d3cc73f59b9a9a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6414b570f051d9e4d1334ec9aaa345cbffabaf1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6414b570f051d9e4d1334ec9aaa345cbffabaf1",
"title": "b6414b570f051d9e4d1334ec9aaa345cbffabaf1",
"url": "https://llvm.googlesource.com/llvm-project/+/b6414b570f051d9e4d1334ec9aaa345cbffabaf1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c3019ecf4e849d1a9fc14559f06ac77d911ce13"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c3019ecf4e849d1a9fc14559f06ac77d911ce13",
"title": "8c3019ecf4e849d1a9fc14559f06ac77d911ce13",
"url": "https://llvm.googlesource.com/llvm-project/+/8c3019ecf4e849d1a9fc14559f06ac77d911ce13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b167db63a9d86fb1c558925c3d76d782d78b034"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b167db63a9d86fb1c558925c3d76d782d78b034",
"title": "8b167db63a9d86fb1c558925c3d76d782d78b034",
"url": "https://llvm.googlesource.com/llvm-project/+/8b167db63a9d86fb1c558925c3d76d782d78b034"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e21f2b696bcad96e8ad5f284e70c1685ea8a44e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e21f2b696bcad96e8ad5f284e70c1685ea8a44e",
"title": "5e21f2b696bcad96e8ad5f284e70c1685ea8a44e",
"url": "https://llvm.googlesource.com/llvm-project/+/5e21f2b696bcad96e8ad5f284e70c1685ea8a44e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa71344acdb1a861c1d74345a3fc80aef48bb4b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa71344acdb1a861c1d74345a3fc80aef48bb4b3",
"title": "aa71344acdb1a861c1d74345a3fc80aef48bb4b3",
"url": "https://llvm.googlesource.com/llvm-project/+/aa71344acdb1a861c1d74345a3fc80aef48bb4b3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aa71344acdb1a861c1d74345a3fc80aef48bb4b3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878345666156438096"
},
{
"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"
}
}
[08:46:29.770] Scheduled build:
{
"id": "8712915604245365025",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-05T08:46:29.423088714Z",
"updateTime": "2025-06-05T08:46:29.423088714Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aa71344acdb1a861c1d74345a3fc80aef48bb4b3",
"ref": "refs/heads/main"
}
}
}
[08:46:29.770] Task URL: https://cr-buildbucket.appspot.com/build/8712915604245365025
[08:46:29.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:2:0) after 8m59s
[08:46:30.770] Received PubSub notification, asking Buildbucket for the build status
[08:46:30.796] Build status: SCHEDULED
[08:46:34.172] Received PubSub notification, asking Buildbucket for the build status
[08:46:34.199] Build status: STARTED
[08:55:28.794] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:2:0)
[08:55:28.813] Build status: STARTED
[08:55:28.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:5:0) after 8m49s
[09:04:17.802] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:5:0)
[09:04:17.833] Build status: STARTED
[09:04:17.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:6:0) after 3m16s
[09:07:33.855] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:6:0)
[09:07:33.884] Build status: STARTED
[09:07:33.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:7:0) after 7m6s
[09:14:40.129] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:7:0)
[09:14:40.183] Build status: STARTED
[09:14:40.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:8:0) after 8m42s
[09:23:22.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:8:0)
[09:23:22.639] Build status: STARTED
[09:23:22.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:9:0) after 5m40s
[09:29:02.668] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:9:0)
[09:29:02.713] Build status: STARTED
[09:29:02.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:10:0) after 7m23s
[09:36:26.012] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:10:0)
[09:36:26.038] Build status: STARTED
[09:36:26.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:11:0) after 2m14s
[09:38:40.056] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:11:0)
[09:38:40.108] Build status: STARTED
[09:38:40.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:12:0) after 6m50s
[09:45:30.421] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:12:0)
[09:45:30.448] Build status: STARTED
[09:45:30.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:13:0) after 1m56s
[09:47:26.473] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:13:0)
[09:47:26.494] Build status: STARTED
[09:47:26.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:14:0) after 7m31s
[09:54:57.855] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:14:0)
[09:54:57.891] Build status: STARTED
[09:54:57.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:15:0) after 4m50s
[09:59:47.965] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:15:0)
[09:59:47.999] Build status: STARTED
[09:59:47.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:16:0) after 9m44s
[10:09:32.166] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:16:0)
[10:09:32.211] Build status: STARTED
[10:09:32.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:17:0) after 2m3s
[10:11:35.266] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:17:0)
[10:11:35.293] Build status: STARTED
[10:11:35.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:18:0) after 9m13s
[10:20:48.580] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:18:0)
[10:20:48.605] Build status: STARTED
[10:20:48.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:19:0) after 6m42s
[10:27:30.643] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:19:0)
[10:27:30.716] Build status: STARTED
[10:27:30.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:20:0) after 4m58s
[10:32:29.034] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:20:0)
[10:32:29.061] Build status: STARTED
[10:32:29.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8878345666156438096:21:0) after 7m52s
[10:33:10.045] Received PubSub notification, asking Buildbucket for the build status
[10:33:10.062] Build:
{
"id": "8712915604245365025",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-05T08:46:29.423088714Z",
"startTime": "2025-06-05T08:46:33.858899285Z",
"endTime": "2025-06-05T10:32:29.640766555Z",
"updateTime": "2025-06-05T10:32:29.640766555Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aa71344acdb1a861c1d74345a3fc80aef48bb4b3",
"ref": "refs/heads/main"
}
}
}
[10:33:10.062] Invocation finished in 1h46m41.844968009s with status FAILED