[12:01:38.586] New invocation is queued and will start shortly
[12:01:38.586] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[12:01:39.647] Starting the invocation (attempt 1)
[12:01:39.676] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/e3ee7f7aea5b45af3b42b5e4713da43876a65ac9"
[12:01:39.676] Reconstructed gitiles commit from tags
[12:01:39.676] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:01:39.676] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:01:39.677] Buildbucket request:
{
"requestId": "8873169359872356752",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2b7f584742c58caf7e309e9d7f8377153d060445",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "cb7046a1ad78e51a1c8c09e8a09fa0da9578e0b04e815424388dc399e3dcc4ca/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873169359872356752",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2b7f584742c58caf7e309e9d7f8377153d060445",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "e12cb8a7280a20d408d828588f86c16a5b74942d71028dfc4c2f7ecd4d5a46d8/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/e3ee7f7aea5b45af3b42b5e4713da43876a65ac9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64-bootstrap",
"user_agent:recipe"
]
},
"id": "9f05a74e-7439-4f3d-bfd1-b52ab878ed20",
"title": "rust-linux-x64-bootstrap/0",
"url": "https://cr-buildbucket.appspot.com/build/8707745518756223425"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2b7f584742c58caf7e309e9d7f8377153d060445",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "cb7046a1ad78e51a1c8c09e8a09fa0da9578e0b04e815424388dc399e3dcc4ca/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/e3ee7f7aea5b45af3b42b5e4713da43876a65ac9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64",
"user_agent:recipe"
]
},
"id": "86ba00a4-73fd-4c66-86f3-57108d67d716",
"title": "rust-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8707745519738700273"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873169359872356752"
},
{
"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"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:01:40.088] Scheduled build:
{
"id": "8707739298000058577",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-01T12:01:39.743928600Z",
"updateTime": "2025-08-01T12:01:39.743928600Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9",
"ref": "refs/heads/main"
}
}
}
[12:01:40.088] Task URL: https://cr-buildbucket.appspot.com/build/8707739298000058577
[12:01:40.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:2:0) after 7m8s
[12:01:41.037] Received PubSub notification, asking Buildbucket for the build status
[12:01:41.070] Build status: SCHEDULED
[12:01:53.866] Received PubSub notification, asking Buildbucket for the build status
[12:01:53.895] Build status: STARTED
[12:08:48.122] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:2:0)
[12:08:48.160] Build status: STARTED
[12:08:48.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:5:0) after 1m12s
[12:10:00.267] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:5:0)
[12:10:00.288] Build status: STARTED
[12:10:00.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:6:0) after 9m44s
[12:19:44.597] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:6:0)
[12:19:44.623] Build status: STARTED
[12:19:44.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:7:0) after 5m30s
[12:25:14.766] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:7:0)
[12:25:14.806] Build status: STARTED
[12:25:14.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:8:0) after 7m10s
[12:32:25.493] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:8:0)
[12:32:25.521] Build status: STARTED
[12:32:25.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:9:0) after 9m49s
[12:42:14.538] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:9:0)
[12:42:14.559] Build status: STARTED
[12:42:14.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:10:0) after 9m16s
[12:51:30.578] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:10:0)
[12:51:30.596] Build status: STARTED
[12:51:30.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:11:0) after 1m11s
[12:52:41.666] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:11:0)
[12:52:41.691] Build status: STARTED
[12:52:41.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:12:0) after 5m5s
[12:57:46.711] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:12:0)
[12:57:46.730] Build status: STARTED
[12:57:46.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:13:0) after 4m19s
[13:02:05.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:13:0)
[13:02:05.774] Build status: STARTED
[13:02:05.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:14:0) after 5m45s
[13:07:50.783] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:14:0)
[13:07:50.802] Build status: STARTED
[13:07:50.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:15:0) after 6m35s
[13:14:25.917] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:15:0)
[13:14:25.934] Build status: STARTED
[13:14:25.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:16:0) after 1m54s
[13:16:19.994] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:16:0)
[13:16:20.094] Build status: STARTED
[13:16:20.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:17:0) after 1m6s
[13:17:26.118] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:17:0)
[13:17:26.146] Build status: STARTED
[13:17:26.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:18:0) after 2m40s
[13:20:06.203] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:18:0)
[13:20:06.237] Build status: STARTED
[13:20:06.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:19:0) after 9m8s
[13:29:14.631] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:19:0)
[13:29:14.653] Build status: STARTED
[13:29:14.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:20:0) after 3m36s
[13:32:50.867] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:20:0)
[13:32:50.887] Build status: STARTED
[13:32:50.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:21:0) after 7m58s
[13:40:49.400] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:21:0)
[13:40:49.894] Build status: STARTED
[13:40:49.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:22:0) after 9m6s
[13:49:55.963] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:22:0)
[13:49:55.997] Build status: STARTED
[13:49:55.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:23:0) after 8m34s
[13:58:30.048] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:23:0)
[13:58:30.072] Build status: STARTED
[13:58:30.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8873169359872356752:24:0) after 8m0s
[14:02:58.030] Received PubSub notification, asking Buildbucket for the build status
[14:02:58.055] Build:
{
"id": "8707739298000058577",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-01T12:01:39.743928600Z",
"startTime": "2025-08-01T12:01:53.540600581Z",
"endTime": "2025-08-01T14:02:57.566433853Z",
"updateTime": "2025-08-01T14:02:57.566433853Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "e3ee7f7aea5b45af3b42b5e4713da43876a65ac9",
"ref": "refs/heads/main"
}
}
}
[14:02:58.055] Invocation finished in 2h1m19.480869477s with status SUCCEEDED