[11:07:33.331] New invocation is queued and will start shortly
[11:07:34.453] Starting the invocation (attempt 1)
[11:07:34.481] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a59f9951f3e197127fb13d729ad4c52168f29432"
[11:07:34.481] Popped gitiles commit info from properties and tags
[11:07:34.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:07:34.482] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:07:34.482] Buildbucket request:
{
"requestId": "8845812478910006992",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-prod-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8845812478910006992",
"job": "fuchsia/prod-rust-llvm-prod-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fdfb99f6336401e534f611c4b2df5a338e26b997"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fdfb99f6336401e534f611c4b2df5a338e26b997",
"title": "fdfb99f6336401e534f611c4b2df5a338e26b997",
"url": "https://llvm.googlesource.com/llvm-project/+/fdfb99f6336401e534f611c4b2df5a338e26b997"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e3f80fe493c1e7d4701d6c08a57f106f99d15380"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e3f80fe493c1e7d4701d6c08a57f106f99d15380",
"title": "e3f80fe493c1e7d4701d6c08a57f106f99d15380",
"url": "https://llvm.googlesource.com/llvm-project/+/e3f80fe493c1e7d4701d6c08a57f106f99d15380"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f15904ec71a8ac092aaca29bddb5f419f2919b6b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f15904ec71a8ac092aaca29bddb5f419f2919b6b",
"title": "f15904ec71a8ac092aaca29bddb5f419f2919b6b",
"url": "https://llvm.googlesource.com/llvm-project/+/f15904ec71a8ac092aaca29bddb5f419f2919b6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80ad13af63ef25d4e62adce6e3362f659b5c521f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80ad13af63ef25d4e62adce6e3362f659b5c521f",
"title": "80ad13af63ef25d4e62adce6e3362f659b5c521f",
"url": "https://llvm.googlesource.com/llvm-project/+/80ad13af63ef25d4e62adce6e3362f659b5c521f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a59f9951f3e197127fb13d729ad4c52168f29432"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a59f9951f3e197127fb13d729ad4c52168f29432",
"title": "a59f9951f3e197127fb13d729ad4c52168f29432",
"url": "https://llvm.googlesource.com/llvm-project/+/a59f9951f3e197127fb13d729ad4c52168f29432"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a59f9951f3e197127fb13d729ad4c52168f29432",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8845812478910006992"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-rust-llvm-prod-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:07:34.842] Scheduled build:
{
"id": "8680382416982430449",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-30T11:07:34.547334912Z",
"updateTime": "2026-05-30T11:07:34.547334912Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a59f9951f3e197127fb13d729ad4c52168f29432",
"ref": "refs/heads/main"
}
}
}
[11:07:34.842] Task URL: https://cr-buildbucket.appspot.com/build/8680382416982430449
[11:07:34.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:2:0) after 5m30s
[11:07:38.143] Received PubSub notification, asking Buildbucket for the build status
[11:07:38.214] Build status: SCHEDULED
[11:07:45.206] Received PubSub notification, asking Buildbucket for the build status
[11:07:45.239] Build status: STARTED
[11:13:04.828] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:2:0)
[11:13:04.845] Build status: STARTED
[11:13:04.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:5:0) after 8m12s
[11:21:16.857] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:5:0)
[11:21:16.880] Build status: STARTED
[11:21:16.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:6:0) after 2m49s
[11:24:05.908] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:6:0)
[11:24:05.930] Build status: STARTED
[11:24:05.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:7:0) after 3m37s
[11:27:42.990] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:7:0)
[11:27:43.009] Build status: STARTED
[11:27:43.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:8:0) after 6m42s
[11:34:25.444] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:8:0)
[11:34:25.466] Build status: STARTED
[11:34:25.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:9:0) after 6m42s
[11:41:07.523] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:9:0)
[11:41:07.538] Build status: STARTED
[11:41:07.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:10:0) after 7m45s
[11:48:52.647] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:10:0)
[11:48:52.661] Build status: STARTED
[11:48:52.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:11:0) after 1m20s
[11:50:12.701] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:11:0)
[11:50:12.771] Build status: STARTED
[11:50:12.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:12:0) after 3m35s
[11:53:47.875] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:12:0)
[11:53:47.887] Build status: STARTED
[11:53:47.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:13:0) after 9m17s
[12:03:04.902] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:13:0)
[12:03:04.922] Build status: STARTED
[12:03:04.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:14:0) after 4m12s
[12:07:16.948] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:14:0)
[12:07:17.022] Build status: STARTED
[12:07:17.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:15:0) after 1m12s
[12:08:29.036] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:15:0)
[12:08:29.059] Build status: STARTED
[12:08:29.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:16:0) after 7m23s
[12:15:52.076] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:16:0)
[12:15:52.133] Build status: STARTED
[12:15:52.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:17:0) after 4m42s
[12:20:34.171] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:17:0)
[12:20:34.196] Build status: STARTED
[12:20:34.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:18:0) after 4m21s
[12:24:55.210] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:18:0)
[12:24:55.230] Build status: STARTED
[12:24:55.230] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:19:0) after 2m32s
[12:27:27.243] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:19:0)
[12:27:27.309] Build status: STARTED
[12:27:27.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:20:0) after 2m18s
[12:29:45.293] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:20:0)
[12:29:45.311] Build status: STARTED
[12:29:45.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:21:0) after 2m4s
[12:31:49.326] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:21:0)
[12:31:49.347] Build status: STARTED
[12:31:49.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:22:0) after 4m55s
[12:36:44.884] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:22:0)
[12:36:44.914] Build status: STARTED
[12:36:44.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:23:0) after 4m13s
[12:40:58.051] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:23:0)
[12:40:58.072] Build status: STARTED
[12:40:58.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:24:0) after 6m37s
[12:47:35.939] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:24:0)
[12:47:35.958] Build status: STARTED
[12:47:35.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:25:0) after 6m55s
[12:54:31.225] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:25:0)
[12:54:31.263] Build status: STARTED
[12:54:31.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:26:0) after 5m17s
[12:59:48.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:26:0)
[12:59:48.696] Build status: STARTED
[12:59:48.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:27:0) after 6m3s
[13:05:51.782] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:27:0)
[13:05:51.813] Build status: STARTED
[13:05:51.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:28:0) after 4m28s
[13:10:19.881] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:28:0)
[13:10:19.910] Build status: STARTED
[13:10:19.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:29:0) after 2m36s
[13:12:55.924] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:29:0)
[13:12:56.025] Build status: STARTED
[13:12:56.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:30:0) after 8m31s
[13:21:27.127] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:30:0)
[13:21:27.148] Build status: STARTED
[13:21:27.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:31:0) after 2m2s
[13:23:29.307] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:31:0)
[13:23:29.327] Build status: STARTED
[13:23:29.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:32:0) after 8m9s
[13:31:38.472] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:32:0)
[13:31:38.495] Build status: STARTED
[13:31:38.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:33:0) after 7m56s
[13:39:34.512] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:33:0)
[13:39:34.528] Build status: STARTED
[13:39:34.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:34:0) after 6m29s
[13:46:03.722] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:34:0)
[13:46:03.738] Build status: STARTED
[13:46:03.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:35:0) after 5m50s
[13:51:53.757] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:35:0)
[13:51:53.777] Build status: STARTED
[13:51:53.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:36:0) after 2m55s
[13:54:48.792] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:36:0)
[13:54:48.812] Build status: STARTED
[13:54:48.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:37:0) after 5m25s
[14:00:13.844] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:37:0)
[14:00:13.863] Build status: STARTED
[14:00:13.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:38:0) after 3m24s
[14:03:37.880] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:38:0)
[14:03:37.961] Build status: STARTED
[14:03:37.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-prod-trigger-40be1bb5:8845812478910006992:39:0) after 3m36s
[14:06:00.941] Received PubSub notification, asking Buildbucket for the build status
[14:06:01.030] Build:
{
"id": "8680382416982430449",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-30T11:07:34.547334912Z",
"startTime": "2026-05-30T11:07:44.751938337Z",
"endTime": "2026-05-30T14:05:58.588988219Z",
"updateTime": "2026-05-30T14:05:58.588988219Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a59f9951f3e197127fb13d729ad4c52168f29432",
"ref": "refs/heads/main"
}
}
}
[14:06:01.030] Invocation finished in 2h58m27.704792253s with status SUCCEEDED