[07:14:32.603] New invocation is queued and will start shortly
[07:14:33.717] Starting the invocation (attempt 1)
[07:14:33.752] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e6f5aa9e2b69d1e84bd281c2525004800828b30d"
[07:14:33.752] Popped gitiles commit info from properties and tags
[07:14:33.752] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:14:33.752] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:14:33.752] Buildbucket request:
{
"requestId": "8870831901501802000",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870831901501802000",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de99aabed6664b16e5bc30edd27680a9b7ae0dd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de99aabed6664b16e5bc30edd27680a9b7ae0dd3",
"title": "de99aabed6664b16e5bc30edd27680a9b7ae0dd3",
"url": "https://llvm.googlesource.com/llvm-project/+/de99aabed6664b16e5bc30edd27680a9b7ae0dd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e587b1b15feccf70a950d17ad37e3c361a9f198"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e587b1b15feccf70a950d17ad37e3c361a9f198",
"title": "5e587b1b15feccf70a950d17ad37e3c361a9f198",
"url": "https://llvm.googlesource.com/llvm-project/+/5e587b1b15feccf70a950d17ad37e3c361a9f198"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61526f57b4443d66592044639676af35c7a923c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61526f57b4443d66592044639676af35c7a923c8",
"title": "61526f57b4443d66592044639676af35c7a923c8",
"url": "https://llvm.googlesource.com/llvm-project/+/61526f57b4443d66592044639676af35c7a923c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0c472d50f29d47223d3fc362ae11d9bff966dac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0c472d50f29d47223d3fc362ae11d9bff966dac",
"title": "a0c472d50f29d47223d3fc362ae11d9bff966dac",
"url": "https://llvm.googlesource.com/llvm-project/+/a0c472d50f29d47223d3fc362ae11d9bff966dac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f005e2cb7aea4ed74a62bfbb1dce51e063cd52a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f005e2cb7aea4ed74a62bfbb1dce51e063cd52a0",
"title": "f005e2cb7aea4ed74a62bfbb1dce51e063cd52a0",
"url": "https://llvm.googlesource.com/llvm-project/+/f005e2cb7aea4ed74a62bfbb1dce51e063cd52a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "640dc21242b69b63f9c130b8dc62bad32c4db4a3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@640dc21242b69b63f9c130b8dc62bad32c4db4a3",
"title": "640dc21242b69b63f9c130b8dc62bad32c4db4a3",
"url": "https://llvm.googlesource.com/llvm-project/+/640dc21242b69b63f9c130b8dc62bad32c4db4a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58f3b0dd8d7b2e09d82dae95908cf34ef50468af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58f3b0dd8d7b2e09d82dae95908cf34ef50468af",
"title": "58f3b0dd8d7b2e09d82dae95908cf34ef50468af",
"url": "https://llvm.googlesource.com/llvm-project/+/58f3b0dd8d7b2e09d82dae95908cf34ef50468af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a16211c0321f3b8000836b5b3742ce4444745f69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a16211c0321f3b8000836b5b3742ce4444745f69",
"title": "a16211c0321f3b8000836b5b3742ce4444745f69",
"url": "https://llvm.googlesource.com/llvm-project/+/a16211c0321f3b8000836b5b3742ce4444745f69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e6f5aa9e2b69d1e84bd281c2525004800828b30d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e6f5aa9e2b69d1e84bd281c2525004800828b30d",
"title": "e6f5aa9e2b69d1e84bd281c2525004800828b30d",
"url": "https://llvm.googlesource.com/llvm-project/+/e6f5aa9e2b69d1e84bd281c2525004800828b30d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6f5aa9e2b69d1e84bd281c2525004800828b30d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870831901501802000"
},
{
"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"
}
}
[07:14:34.202] Scheduled build:
{
"id": "8705401839579069553",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-27T07:14:33.805463946Z",
"updateTime": "2025-08-27T07:14:33.805463946Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6f5aa9e2b69d1e84bd281c2525004800828b30d",
"ref": "refs/heads/main"
}
}
}
[07:14:34.202] Task URL: https://cr-buildbucket.appspot.com/build/8705401839579069553
[07:14:34.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:2:0) after 8m17s
[07:14:35.185] Received PubSub notification, asking Buildbucket for the build status
[07:14:35.248] Build status: SCHEDULED
[07:22:51.215] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:2:0)
[07:22:51.331] Build status: SCHEDULED
[07:22:51.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:4:0) after 3m2s
[07:25:53.306] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:4:0)
[07:25:53.323] Build status: SCHEDULED
[07:25:53.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:5:0) after 3m9s
[07:29:02.358] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:5:0)
[07:29:02.384] Build status: SCHEDULED
[07:29:02.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:6:0) after 9m45s
[07:38:47.403] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:6:0)
[07:38:47.714] Build status: SCHEDULED
[07:38:47.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:7:0) after 9m11s
[07:47:58.743] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:7:0)
[07:47:58.759] Build status: SCHEDULED
[07:47:58.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:8:0) after 6m29s
[07:54:28.453] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:8:0)
[07:54:28.489] Build status: SCHEDULED
[07:54:28.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:9:0) after 8m22s
[08:02:51.227] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:9:0)
[08:02:51.243] Build status: SCHEDULED
[08:02:51.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:10:0) after 8m46s
[08:08:50.181] Received PubSub notification, asking Buildbucket for the build status
[08:08:50.202] Build status: STARTED
[08:11:37.258] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:10:0)
[08:11:37.319] Build status: STARTED
[08:11:37.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:12:0) after 3m46s
[08:15:23.337] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:12:0)
[08:15:23.368] Build status: STARTED
[08:15:23.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:13:0) after 8m20s
[08:23:43.391] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:13:0)
[08:23:43.414] Build status: STARTED
[08:23:43.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:14:0) after 5m58s
[08:29:41.464] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:14:0)
[08:29:41.493] Build status: STARTED
[08:29:41.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:15:0) after 8m21s
[08:38:02.563] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:15:0)
[08:38:02.782] Build status: STARTED
[08:38:02.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:16:0) after 8m19s
[08:46:21.801] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:16:0)
[08:46:21.827] Build status: STARTED
[08:46:21.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:17:0) after 4m21s
[08:50:43.036] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:17:0)
[08:50:43.061] Build status: STARTED
[08:50:43.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:18:0) after 9m29s
[09:00:12.170] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:18:0)
[09:00:12.203] Build status: STARTED
[09:00:12.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:19:0) after 1m49s
[09:02:01.475] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:19:0)
[09:02:01.498] Build status: STARTED
[09:02:01.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:20:0) after 9m56s
[09:11:57.534] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:20:0)
[09:11:57.551] Build status: STARTED
[09:11:57.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8870831901501802000:21:0) after 9m26s
[09:17:52.690] Received PubSub notification, asking Buildbucket for the build status
[09:17:52.717] Build:
{
"id": "8705401839579069553",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-27T07:14:33.805463946Z",
"startTime": "2025-08-27T08:08:50.001642950Z",
"endTime": "2025-08-27T09:17:51.967513297Z",
"updateTime": "2025-08-27T09:17:51.967513297Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6f5aa9e2b69d1e84bd281c2525004800828b30d",
"ref": "refs/heads/main"
}
}
}
[09:17:52.717] Invocation finished in 2h3m20.128674419s with status SUCCEEDED