[07:49:30.956] New invocation is queued and will start shortly
[07:49:30.956] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[07:49:32.159] Starting the invocation (attempt 1)
[07:49:32.190] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/53af067bb0b4edf9b5394e5f9b60942974b9fbc2"
[07:49:32.190] Reconstructed gitiles commit from tags
[07:49:32.190] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:49:32.190] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:49:32.190] Buildbucket request:
{
"requestId": "8872279252672789440",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2e1dc7835cfeff6a8b4c3679ae68fead179e84bb",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "1587e9758d78f2b8b67bcd1833ad11f5cfcfcea79e004697e0dddb6a44d8731b/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872279252672789440",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2e1dc7835cfeff6a8b4c3679ae68fead179e84bb",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "d0ef587d06f7eea25783da3b1aed4cd012452543f81c2818a298dd769f0efa8b/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/53af067bb0b4edf9b5394e5f9b60942974b9fbc2",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64-bootstrap",
"user_agent:recipe"
]
},
"id": "a21d6acc-2298-4ef3-8c53-bcc6bd8f92ca",
"title": "rust-linux-x64-bootstrap/0",
"url": "https://cr-buildbucket.appspot.com/build/8706855897658331121"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2e1dc7835cfeff6a8b4c3679ae68fead179e84bb",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "1587e9758d78f2b8b67bcd1833ad11f5cfcfcea79e004697e0dddb6a44d8731b/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/53af067bb0b4edf9b5394e5f9b60942974b9fbc2",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64",
"user_agent:recipe"
]
},
"id": "6ab5c762-b4e3-42e3-91c9-0421f6e171ea",
"title": "rust-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8706855897010600769"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872279252672789440"
},
{
"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"
}
}
[07:49:32.572] Scheduled build:
{
"id": "8706849190644237521",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-11T07:49:32.268556589Z",
"updateTime": "2025-08-11T07:49:32.268556589Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2",
"ref": "refs/heads/main"
}
}
}
[07:49:32.573] Task URL: https://cr-buildbucket.appspot.com/build/8706849190644237521
[07:49:32.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:2:0) after 3m49s
[07:49:33.538] Received PubSub notification, asking Buildbucket for the build status
[07:49:33.602] Build status: SCHEDULED
[07:49:36.454] Received PubSub notification, asking Buildbucket for the build status
[07:49:36.482] Build status: STARTED
[07:53:21.588] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:2:0)
[07:53:21.610] Build status: STARTED
[07:53:21.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:5:0) after 5m28s
[07:58:49.679] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:5:0)
[07:58:49.700] Build status: STARTED
[07:58:49.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:6:0) after 7m52s
[08:06:41.715] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:6:0)
[08:06:41.737] Build status: STARTED
[08:06:41.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:7:0) after 5m39s
[08:12:20.789] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:7:0)
[08:12:20.841] Build status: STARTED
[08:12:20.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:8:0) after 6m44s
[08:19:04.868] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:8:0)
[08:19:04.885] Build status: STARTED
[08:19:04.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:9:0) after 3m6s
[08:22:10.900] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:9:0)
[08:22:10.962] Build status: STARTED
[08:22:10.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:10:0) after 9m31s
[08:31:41.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:10:0)
[08:31:42.010] Build status: STARTED
[08:31:42.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:11:0) after 9m51s
[08:41:33.135] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:11:0)
[08:41:33.163] Build status: STARTED
[08:41:33.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:12:0) after 8m33s
[08:50:06.178] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:12:0)
[08:50:06.201] Build status: STARTED
[08:50:06.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:13:0) after 2m1s
[08:52:07.292] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:13:0)
[08:52:07.309] Build status: STARTED
[08:52:07.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:14:0) after 5m23s
[08:57:30.350] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:14:0)
[08:57:30.372] Build status: STARTED
[08:57:30.372] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:15:0) after 3m50s
[09:01:20.385] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:15:0)
[09:01:20.400] Build status: STARTED
[09:01:20.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:16:0) after 8m52s
[09:10:12.424] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:16:0)
[09:10:12.465] Build status: STARTED
[09:10:12.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:17:0) after 4m58s
[09:15:10.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:17:0)
[09:15:10.695] Build status: STARTED
[09:15:10.695] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:18:0) after 5m50s
[09:21:00.843] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:18:0)
[09:21:00.866] Build status: STARTED
[09:21:00.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:19:0) after 5m9s
[09:26:09.985] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:19:0)
[09:26:10.023] Build status: STARTED
[09:26:10.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:20:0) after 1m33s
[09:27:43.042] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:20:0)
[09:27:43.337] Build status: STARTED
[09:27:43.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:21:0) after 2m28s
[09:30:11.430] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:21:0)
[09:30:11.456] Build status: STARTED
[09:30:11.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:22:0) after 9m25s
[09:39:36.518] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:22:0)
[09:39:36.538] Build status: STARTED
[09:39:36.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:23:0) after 7m54s
[09:47:30.609] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:23:0)
[09:47:30.628] Build status: STARTED
[09:47:30.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8872279252672789440:24:0) after 6m15s
[09:50:11.717] Received PubSub notification, asking Buildbucket for the build status
[09:50:11.869] Build:
{
"id": "8706849190644237521",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-11T07:49:32.268556589Z",
"startTime": "2025-08-11T07:49:36.268205375Z",
"endTime": "2025-08-11T09:50:11.207815236Z",
"updateTime": "2025-08-11T09:50:11.207815236Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "53af067bb0b4edf9b5394e5f9b60942974b9fbc2",
"ref": "refs/heads/main"
}
}
}
[09:50:11.869] Invocation finished in 2h0m40.920596246s with status SUCCEEDED