[14:02:25.239] New invocation is queued and will start shortly
[14:02:26.456] Starting the invocation (attempt 1)
[14:02:26.484] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/b50f345a2f3f49764024cabc30ef99e15c0240f7"
[14:02:26.484] Popped gitiles commit info from properties and tags
[14:02:26.484] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:02:26.484] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:02:26.484] Buildbucket request:
{
"requestId": "8869266091645504400",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8869266091645504400",
"job": "fuchsia/toolchain.ci-rust_stage0_trigger-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f8a7f82bdab57302ca07ea5f3b3fa5173ed9f9ae"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f8a7f82bdab57302ca07ea5f3b3fa5173ed9f9ae",
"title": "f8a7f82bdab57302ca07ea5f3b3fa5173ed9f9ae",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f8a7f82bdab57302ca07ea5f3b3fa5173ed9f9ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "472721b34f73e7a5e6870c9443c35e3ab29958d9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@472721b34f73e7a5e6870c9443c35e3ab29958d9",
"title": "472721b34f73e7a5e6870c9443c35e3ab29958d9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/472721b34f73e7a5e6870c9443c35e3ab29958d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "43a6b1041819c5f5b70faf1ad5833400087dc1b0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@43a6b1041819c5f5b70faf1ad5833400087dc1b0",
"title": "43a6b1041819c5f5b70faf1ad5833400087dc1b0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/43a6b1041819c5f5b70faf1ad5833400087dc1b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a0bb9cc57db551289cba9fefde086e45cb82733f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a0bb9cc57db551289cba9fefde086e45cb82733f",
"title": "a0bb9cc57db551289cba9fefde086e45cb82733f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a0bb9cc57db551289cba9fefde086e45cb82733f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "957fa10d50787a4c6c6d8a35be5af6bd43ba1770"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@957fa10d50787a4c6c6d8a35be5af6bd43ba1770",
"title": "957fa10d50787a4c6c6d8a35be5af6bd43ba1770",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/957fa10d50787a4c6c6d8a35be5af6bd43ba1770"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f157ce994ea45e9faea9eff89c5f8b3d4ea77b6e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f157ce994ea45e9faea9eff89c5f8b3d4ea77b6e",
"title": "f157ce994ea45e9faea9eff89c5f8b3d4ea77b6e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f157ce994ea45e9faea9eff89c5f8b3d4ea77b6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "544644476d9c304648801dae76d85b1c17fc35d1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@544644476d9c304648801dae76d85b1c17fc35d1",
"title": "544644476d9c304648801dae76d85b1c17fc35d1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/544644476d9c304648801dae76d85b1c17fc35d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5b37a1e4aea3fc2b70d1062d65c88269412dd938"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5b37a1e4aea3fc2b70d1062d65c88269412dd938",
"title": "5b37a1e4aea3fc2b70d1062d65c88269412dd938",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5b37a1e4aea3fc2b70d1062d65c88269412dd938"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "82bb6d523bf3b1e6cd8d160565ab18d01640a4dd"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@82bb6d523bf3b1e6cd8d160565ab18d01640a4dd",
"title": "82bb6d523bf3b1e6cd8d160565ab18d01640a4dd",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/82bb6d523bf3b1e6cd8d160565ab18d01640a4dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7be418947e858d0b6f52d453ef377cd77de9aeaf"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7be418947e858d0b6f52d453ef377cd77de9aeaf",
"title": "7be418947e858d0b6f52d453ef377cd77de9aeaf",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7be418947e858d0b6f52d453ef377cd77de9aeaf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c4539b2d58d97093fc08a42561397fa98e75c684"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c4539b2d58d97093fc08a42561397fa98e75c684",
"title": "c4539b2d58d97093fc08a42561397fa98e75c684",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c4539b2d58d97093fc08a42561397fa98e75c684"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b50f345a2f3f49764024cabc30ef99e15c0240f7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b50f345a2f3f49764024cabc30ef99e15c0240f7",
"title": "b50f345a2f3f49764024cabc30ef99e15c0240f7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b50f345a2f3f49764024cabc30ef99e15c0240f7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b50f345a2f3f49764024cabc30ef99e15c0240f7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869266091645504400"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust_stage0_trigger-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:02:26.915] Scheduled build:
{
"id": "8703836029621112257",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-13T14:02:26.546682118Z",
"updateTime": "2025-09-13T14:02:26.546682118Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b50f345a2f3f49764024cabc30ef99e15c0240f7",
"ref": "refs/heads/main"
}
}
}
[14:02:26.915] Task URL: https://cr-buildbucket.appspot.com/build/8703836029621112257
[14:02:26.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:2:0) after 1m46s
[14:02:27.877] Received PubSub notification, asking Buildbucket for the build status
[14:02:27.900] Build status: SCHEDULED
[14:02:31.435] Received PubSub notification, asking Buildbucket for the build status
[14:02:31.458] Build status: STARTED
[14:04:13.388] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:2:0)
[14:04:13.445] Build status: STARTED
[14:04:13.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:5:0) after 2m22s
[14:06:35.769] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:5:0)
[14:06:35.783] Build status: STARTED
[14:06:35.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:6:0) after 7m0s
[14:13:35.824] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:6:0)
[14:13:35.846] Build status: STARTED
[14:13:35.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:7:0) after 8m48s
[14:22:24.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:7:0)
[14:22:24.250] Build status: STARTED
[14:22:24.250] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:8:0) after 6m17s
[14:28:41.404] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:8:0)
[14:28:41.421] Build status: STARTED
[14:28:41.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:9:0) after 8m10s
[14:36:51.648] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:9:0)
[14:36:51.665] Build status: STARTED
[14:36:51.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:10:0) after 7m4s
[14:43:55.683] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:10:0)
[14:43:55.706] Build status: STARTED
[14:43:55.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:11:0) after 2m38s
[14:46:33.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:11:0)
[14:46:33.987] Build status: STARTED
[14:46:33.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:12:0) after 3m9s
[14:49:43.054] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:12:0)
[14:49:43.091] Build status: STARTED
[14:49:43.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:13:0) after 6m9s
[14:55:52.258] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:13:0)
[14:55:52.342] Build status: STARTED
[14:55:52.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:14:0) after 1m18s
[14:57:10.488] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:14:0)
[14:57:10.502] Build status: STARTED
[14:57:10.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:15:0) after 4m54s
[15:02:04.507] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:15:0)
[15:02:04.525] Build status: STARTED
[15:02:04.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:16:0) after 2m5s
[15:04:09.625] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:16:0)
[15:04:09.641] Build status: STARTED
[15:04:09.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:17:0) after 5m44s
[15:09:53.658] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:17:0)
[15:09:53.675] Build status: STARTED
[15:09:53.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:18:0) after 6m5s
[15:15:58.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:18:0)
[15:15:58.856] Build status: STARTED
[15:15:58.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:19:0) after 7m12s
[15:23:11.206] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:19:0)
[15:23:11.243] Build status: STARTED
[15:23:11.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:20:0) after 1m25s
[15:24:36.757] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:20:0)
[15:24:36.907] Build status: STARTED
[15:24:36.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:21:0) after 7m46s
[15:32:22.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:21:0)
[15:32:23.084] Build status: STARTED
[15:32:23.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:22:0) after 5m22s
[15:37:45.495] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:22:0)
[15:37:45.512] Build status: STARTED
[15:37:45.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:23:0) after 3m4s
[15:40:49.695] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:23:0)
[15:40:49.718] Build status: STARTED
[15:40:49.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:24:0) after 9m50s
[15:50:39.883] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:24:0)
[15:50:39.901] Build status: STARTED
[15:50:39.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:25:0) after 4m35s
[15:55:14.966] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:25:0)
[15:55:14.986] Build status: STARTED
[15:55:14.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:26:0) after 2m59s
[15:58:14.027] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:26:0)
[15:58:14.044] Build status: STARTED
[15:58:14.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:27:0) after 5m16s
[16:03:30.212] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:27:0)
[16:03:30.228] Build status: STARTED
[16:03:30.228] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:28:0) after 3m48s
[16:07:18.315] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:28:0)
[16:07:18.337] Build status: STARTED
[16:07:18.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:29:0) after 5m37s
[16:12:55.362] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:29:0)
[16:12:55.414] Build status: STARTED
[16:12:55.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:30:0) after 4m9s
[16:17:04.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:30:0)
[16:17:04.724] Build status: STARTED
[16:17:04.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:31:0) after 2m55s
[16:19:59.740] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:31:0)
[16:19:59.807] Build status: STARTED
[16:19:59.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:32:0) after 5m14s
[16:25:13.824] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:32:0)
[16:25:13.844] Build status: STARTED
[16:25:13.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:33:0) after 8m45s
[16:33:58.929] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:33:0)
[16:33:58.946] Build status: STARTED
[16:33:58.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:34:0) after 6m55s
[16:40:54.059] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:34:0)
[16:40:54.169] Build status: STARTED
[16:40:54.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8869266091645504400:35:0) after 7m32s
[16:47:14.107] Received PubSub notification, asking Buildbucket for the build status
[16:47:14.174] Build:
{
"id": "8703836029621112257",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-13T14:02:26.546682118Z",
"startTime": "2025-09-13T14:02:31.271310677Z",
"endTime": "2025-09-13T16:47:13.500426166Z",
"updateTime": "2025-09-13T16:47:13.500426166Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b50f345a2f3f49764024cabc30ef99e15c0240f7",
"ref": "refs/heads/main"
}
}
}
[16:47:14.174] Invocation finished in 2h44m48.941928144s with status FAILED