[18:45:30.835] New invocation is queued and will start shortly
[18:45:30.835] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[18:45:32.062] Starting the invocation (attempt 1)
[18:45:32.106] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/5d1b897a07dc30d810dd541795125c1c216266c7"
[18:45:32.109] Reconstructed gitiles commit from tags
[18:45:32.111] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:45:32.111] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:45:32.112] Buildbucket request:
{
"requestId": "8868885893090858144",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0a6cffb8adb3e361d300f6c178963bb634d99fe8",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "3698d5690e0c3910c078e7b7434b4f2419837b334f8324aaca77be0e2a024620/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868885893090858144",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0a6cffb8adb3e361d300f6c178963bb634d99fe8",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "2bb2ee0b25d3a0fef7b30c9527917711739b2e7d2c5709921461375ceb8ab4b6/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "5d1b897a07dc30d810dd541795125c1c216266c7"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/5d1b897a07dc30d810dd541795125c1c216266c7",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64",
"user_agent:recipe"
]
},
"id": "34f09f7f-5a39-43f3-846e-f9b7f879d01d",
"title": "rust-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8703461653063253009"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0a6cffb8adb3e361d300f6c178963bb634d99fe8",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "3698d5690e0c3910c078e7b7434b4f2419837b334f8324aaca77be0e2a024620/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "5d1b897a07dc30d810dd541795125c1c216266c7"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/5d1b897a07dc30d810dd541795125c1c216266c7",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64-bootstrap",
"user_agent:recipe"
]
},
"id": "7178c28f-da59-4f8f-991e-73bd27c20d1e",
"title": "rust-linux-x64-bootstrap/0",
"url": "https://cr-buildbucket.appspot.com/build/8703461651963969073"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "5d1b897a07dc30d810dd541795125c1c216266c7"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "5d1b897a07dc30d810dd541795125c1c216266c7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868885893090858144"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "rust-linux-x64-bootstrap"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:45:32.507] Scheduled build:
{
"id": "8703455831012840385",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-17T18:45:32.194553255Z",
"updateTime": "2025-09-17T18:45:32.194553255Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "5d1b897a07dc30d810dd541795125c1c216266c7",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:45:32.507] Task URL: https://cr-buildbucket.appspot.com/build/8703455831012840385
[18:45:32.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:2:0) after 3m0s
[18:45:45.472] Received PubSub notification, asking Buildbucket for the build status
[18:45:45.517] Build status: SCHEDULED
[18:46:03.258] Received PubSub notification, asking Buildbucket for the build status
[18:46:03.283] Build status: STARTED
[18:48:32.523] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:2:0)
[18:48:32.552] Build status: STARTED
[18:48:32.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:5:0) after 5m8s
[18:53:40.567] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:5:0)
[18:53:40.589] Build status: STARTED
[18:53:40.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:6:0) after 9m56s
[19:03:36.631] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:6:0)
[19:03:36.656] Build status: STARTED
[19:03:36.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:7:0) after 7m53s
[19:11:29.672] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:7:0)
[19:11:29.692] Build status: STARTED
[19:11:29.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:8:0) after 4m47s
[19:16:16.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:8:0)
[19:16:16.726] Build status: STARTED
[19:16:16.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:9:0) after 5m29s
[19:21:45.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:9:0)
[19:21:45.815] Build status: STARTED
[19:21:45.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:10:0) after 6m10s
[19:27:55.805] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:10:0)
[19:27:55.819] Build status: STARTED
[19:27:55.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:11:0) after 6m19s
[19:34:14.828] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:11:0)
[19:34:14.916] Build status: STARTED
[19:34:14.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:12:0) after 9m33s
[19:43:47.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:12:0)
[19:43:47.984] Build status: STARTED
[19:43:47.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:13:0) after 3m17s
[19:47:05.132] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:13:0)
[19:47:05.148] Build status: STARTED
[19:47:05.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:14:0) after 8m59s
[19:56:04.225] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:14:0)
[19:56:04.249] Build status: STARTED
[19:56:04.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:15:0) after 8m58s
[20:05:02.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:15:0)
[20:05:02.365] Build status: STARTED
[20:05:02.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:16:0) after 8m5s
[20:13:07.427] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:16:0)
[20:13:07.443] Build status: STARTED
[20:13:07.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:17:0) after 5m59s
[20:19:06.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:17:0)
[20:19:06.506] Build status: STARTED
[20:19:06.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:18:0) after 4m27s
[20:23:33.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:18:0)
[20:23:33.692] Build status: STARTED
[20:23:33.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:19:0) after 5m45s
[20:29:18.760] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:19:0)
[20:29:18.791] Build status: STARTED
[20:29:18.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:20:0) after 2m2s
[20:31:20.817] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:20:0)
[20:31:20.835] Build status: STARTED
[20:31:20.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:21:0) after 8m7s
[20:39:27.896] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:21:0)
[20:39:27.919] Build status: STARTED
[20:39:27.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:22:0) after 6m9s
[20:45:36.974] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:22:0)
[20:45:36.992] Build status: STARTED
[20:45:36.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:23:0) after 7m51s
[20:53:28.063] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:23:0)
[20:53:28.080] Build status: STARTED
[20:53:28.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:24:0) after 3m53s
[20:57:21.131] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:24:0)
[20:57:21.148] Build status: STARTED
[20:57:21.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:25:0) after 8m43s
[21:06:04.162] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:25:0)
[21:06:04.178] Build status: STARTED
[21:06:04.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:26:0) after 9m1s
[21:15:05.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:26:0)
[21:15:05.206] Build status: STARTED
[21:15:05.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:27:0) after 6m23s
[21:21:28.222] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:27:0)
[21:21:28.258] Build status: STARTED
[21:21:28.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:28:0) after 1m47s
[21:23:15.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:28:0)
[21:23:15.337] Build status: STARTED
[21:23:15.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8868885893090858144:29:0) after 8m31s
[21:26:23.411] Received PubSub notification, asking Buildbucket for the build status
[21:26:23.432] Build:
{
"id": "8703455831012840385",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-17T18:45:32.194553255Z",
"startTime": "2025-09-17T18:45:51.041430359Z",
"endTime": "2025-09-17T21:26:23.012701377Z",
"updateTime": "2025-09-17T21:26:23.012701377Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "5d1b897a07dc30d810dd541795125c1c216266c7",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:26:23.432] Invocation finished in 2h40m52.603475759s with status SUCCEEDED