[07:59:05.089] New invocation is queued and will start shortly
[07:59:06.158] Starting the invocation (attempt 1)
[07:59:06.183] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/118bcb3c00c18701a74bb12ecefc9353d12f6352"
[07:59:06.183] Popped gitiles commit info from properties and tags
[07:59:06.183] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:59:06.184] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:59:06.184] Buildbucket request:
{
"requestId": "8846367918257604576",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8846367918257604576",
"job": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "02f736922cc852840941d6734df37ca47c2c41e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@02f736922cc852840941d6734df37ca47c2c41e4",
"title": "02f736922cc852840941d6734df37ca47c2c41e4",
"url": "https://llvm.googlesource.com/llvm-project/+/02f736922cc852840941d6734df37ca47c2c41e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "78cbf39d3bc990e4562c98dbddd26cd3de4eca96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@78cbf39d3bc990e4562c98dbddd26cd3de4eca96",
"title": "78cbf39d3bc990e4562c98dbddd26cd3de4eca96",
"url": "https://llvm.googlesource.com/llvm-project/+/78cbf39d3bc990e4562c98dbddd26cd3de4eca96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0ee8a371b673bd864804fd5c0125fbd46dcee31a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0ee8a371b673bd864804fd5c0125fbd46dcee31a",
"title": "0ee8a371b673bd864804fd5c0125fbd46dcee31a",
"url": "https://llvm.googlesource.com/llvm-project/+/0ee8a371b673bd864804fd5c0125fbd46dcee31a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd1649b020081263b3d2a08e3b254d7b4280222f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd1649b020081263b3d2a08e3b254d7b4280222f",
"title": "dd1649b020081263b3d2a08e3b254d7b4280222f",
"url": "https://llvm.googlesource.com/llvm-project/+/dd1649b020081263b3d2a08e3b254d7b4280222f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "118bcb3c00c18701a74bb12ecefc9353d12f6352"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@118bcb3c00c18701a74bb12ecefc9353d12f6352",
"title": "118bcb3c00c18701a74bb12ecefc9353d12f6352",
"url": "https://llvm.googlesource.com/llvm-project/+/118bcb3c00c18701a74bb12ecefc9353d12f6352"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "118bcb3c00c18701a74bb12ecefc9353d12f6352",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8846367918257604576"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:59:06.598] Scheduled build:
{
"id": "8680937856383358353",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-24T07:59:06.256479036Z",
"updateTime": "2026-05-24T07:59:06.256479036Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "118bcb3c00c18701a74bb12ecefc9353d12f6352",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:59:06.598] Task URL: https://cr-buildbucket.appspot.com/build/8680937856383358353
[07:59:06.598] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:2:0) after 9m17s
[07:59:11.150] Received PubSub notification, asking Buildbucket for the build status
[07:59:11.166] Build status: SCHEDULED
[07:59:38.800] Received PubSub notification, asking Buildbucket for the build status
[07:59:38.820] Build status: STARTED
[08:08:24.011] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:2:0)
[08:08:24.067] Build status: STARTED
[08:08:24.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:5:0) after 3m50s
[08:12:14.213] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:5:0)
[08:12:14.231] Build status: STARTED
[08:12:14.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:6:0) after 6m21s
[08:18:35.538] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:6:0)
[08:18:35.560] Build status: STARTED
[08:18:35.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:7:0) after 7m55s
[08:26:30.609] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:7:0)
[08:26:30.648] Build status: STARTED
[08:26:30.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:8:0) after 2m31s
[08:29:01.661] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:8:0)
[08:29:01.681] Build status: STARTED
[08:29:01.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:9:0) after 3m55s
[08:32:56.695] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:9:0)
[08:32:56.727] Build status: STARTED
[08:32:56.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:10:0) after 2m44s
[08:35:40.739] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:10:0)
[08:35:40.762] Build status: STARTED
[08:35:40.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:11:0) after 5m54s
[08:41:35.041] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:11:0)
[08:41:35.165] Build status: STARTED
[08:41:35.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:12:0) after 7m17s
[08:48:52.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:12:0)
[08:48:52.297] Build status: STARTED
[08:48:52.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:13:0) after 5m49s
[08:54:41.620] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:13:0)
[08:54:41.636] Build status: STARTED
[08:54:41.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:14:0) after 4m23s
[08:59:04.740] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:14:0)
[08:59:04.757] Build status: STARTED
[08:59:04.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:15:0) after 4m28s
[09:03:32.775] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:15:0)
[09:03:32.794] Build status: STARTED
[09:03:32.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:16:0) after 7m13s
[09:10:45.810] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:16:0)
[09:10:45.827] Build status: STARTED
[09:10:45.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:17:0) after 8m44s
[09:19:29.842] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:17:0)
[09:19:29.859] Build status: STARTED
[09:19:29.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:18:0) after 6m1s
[09:25:30.972] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:18:0)
[09:25:31.357] Build status: STARTED
[09:25:31.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:19:0) after 6m33s
[09:32:04.445] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:19:0)
[09:32:04.468] Build status: STARTED
[09:32:04.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:20:0) after 2m22s
[09:34:26.825] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:20:0)
[09:34:26.929] Build status: STARTED
[09:34:26.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:21:0) after 9m34s
[09:44:01.135] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:21:0)
[09:44:01.195] Build status: STARTED
[09:44:01.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:22:0) after 6m8s
[09:50:09.489] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:22:0)
[09:50:09.507] Build status: STARTED
[09:50:09.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:23:0) after 8m5s
[09:58:14.523] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:23:0)
[09:58:14.543] Build status: STARTED
[09:58:14.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:24:0) after 2m48s
[10:01:02.559] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:24:0)
[10:01:02.574] Build status: STARTED
[10:01:02.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:25:0) after 9m20s
[10:10:22.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:25:0)
[10:10:22.726] Build status: STARTED
[10:10:22.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:26:0) after 8m40s
[10:19:02.744] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:26:0)
[10:19:02.771] Build status: STARTED
[10:19:02.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:27:0) after 2m58s
[10:22:01.044] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:27:0)
[10:22:01.078] Build status: STARTED
[10:22:01.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:28:0) after 8m40s
[10:30:41.093] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:28:0)
[10:30:41.112] Build status: STARTED
[10:30:41.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:29:0) after 3m45s
[10:34:26.130] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:29:0)
[10:34:26.157] Build status: STARTED
[10:34:26.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:30:0) after 3m8s
[10:37:34.181] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:30:0)
[10:37:34.198] Build status: STARTED
[10:37:34.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:31:0) after 1m54s
[10:39:28.312] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:31:0)
[10:39:28.337] Build status: STARTED
[10:39:28.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:32:0) after 1m15s
[10:40:43.382] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:32:0)
[10:40:43.497] Build status: STARTED
[10:40:43.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:33:0) after 7m28s
[10:48:11.526] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:33:0)
[10:48:11.572] Build status: STARTED
[10:48:11.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:34:0) after 9m50s
[10:58:01.622] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:34:0)
[10:58:01.641] Build status: STARTED
[10:58:01.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:35:0) after 8m27s
[11:06:28.730] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:35:0)
[11:06:28.755] Build status: STARTED
[11:06:28.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:36:0) after 2m20s
[11:08:48.835] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:36:0)
[11:08:48.853] Build status: STARTED
[11:08:48.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:37:0) after 1m42s
[11:10:30.992] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:37:0)
[11:10:31.014] Build status: STARTED
[11:10:31.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:38:0) after 7m45s
[11:18:16.033] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:38:0)
[11:18:16.051] Build status: STARTED
[11:18:16.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8846367918257604576:39:0) after 6m35s
[11:18:39.518] Received PubSub notification, asking Buildbucket for the build status
[11:18:39.547] Build:
{
"id": "8680937856383358353",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-24T07:59:06.256479036Z",
"startTime": "2026-05-24T07:59:34.440054016Z",
"endTime": "2026-05-24T11:18:39.250699741Z",
"updateTime": "2026-05-24T11:18:39.250699741Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "118bcb3c00c18701a74bb12ecefc9353d12f6352",
"ref": "refs/heads/main"
}
},
"canary": true
}
[11:18:39.547] Invocation finished in 3h19m34.462069294s with status SUCCEEDED