[10:45:18.449] New invocation is queued and will start shortly
[10:45:18.449] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[10:45:19.672] Starting the invocation (attempt 1)
[10:45:19.697] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/cf3fb768db439825e3c8d327f6d9f46e02965668"
[10:45:19.697] Reconstructed gitiles commit from tags
[10:45:19.697] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:45:19.697] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:45:19.697] Buildbucket request:
{
"requestId": "8875167295758217248",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "563cfffaace3edbdf50e06d9f847797da64054d3",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "751fedbb04e52df54614ba157374b6762a105c670b455fa15c97495759b9ca50/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875167295758217248",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "563cfffaace3edbdf50e06d9f847797da64054d3",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "751fedbb04e52df54614ba157374b6762a105c670b455fa15c97495759b9ca50/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "cf3fb768db439825e3c8d327f6d9f46e02965668"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/cf3fb768db439825e3c8d327f6d9f46e02965668",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64",
"user_agent:recipe"
]
},
"id": "2942622e-46af-4471-b94d-f4e786dcb5eb",
"title": "rust-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8709739309221920609"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "cf3fb768db439825e3c8d327f6d9f46e02965668"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "cf3fb768db439825e3c8d327f6d9f46e02965668",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875167295758217248"
},
{
"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"
}
}
[10:45:20.117] Scheduled build:
{
"id": "8709737233720794785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-10T10:45:19.761006881Z",
"updateTime": "2025-07-10T10:45:19.761006881Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "cf3fb768db439825e3c8d327f6d9f46e02965668",
"ref": "refs/heads/main"
}
}
}
[10:45:20.117] Task URL: https://cr-buildbucket.appspot.com/build/8709737233720794785
[10:45:20.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:2:0) after 5m17s
[10:45:44.172] Received PubSub notification, asking Buildbucket for the build status
[10:45:44.197] Build status: STARTED
[10:45:47.478] Received PubSub notification, asking Buildbucket for the build status
[10:45:47.505] Build status: STARTED
[10:50:37.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:2:0)
[10:50:37.265] Build status: STARTED
[10:50:37.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:5:0) after 2m38s
[10:53:15.603] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:5:0)
[10:53:15.622] Build status: STARTED
[10:53:15.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:6:0) after 9m59s
[11:03:14.611] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:6:0)
[11:03:14.670] Build status: STARTED
[11:03:14.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:7:0) after 3m56s
[11:07:10.727] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:7:0)
[11:07:10.754] Build status: STARTED
[11:07:10.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:8:0) after 2m37s
[11:09:47.894] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:8:0)
[11:09:47.918] Build status: STARTED
[11:09:47.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:9:0) after 1m49s
[11:11:36.940] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:9:0)
[11:11:36.959] Build status: STARTED
[11:11:36.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:10:0) after 1m27s
[11:13:03.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:10:0)
[11:13:04.014] Build status: STARTED
[11:13:04.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:11:0) after 3m19s
[11:16:23.035] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:11:0)
[11:16:23.085] Build status: STARTED
[11:16:23.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:12:0) after 2m47s
[11:19:10.123] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:12:0)
[11:19:10.212] Build status: STARTED
[11:19:10.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:13:0) after 6m22s
[11:25:32.240] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:13:0)
[11:25:32.267] Build status: STARTED
[11:25:32.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:14:0) after 8m22s
[11:33:54.375] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:14:0)
[11:33:54.398] Build status: STARTED
[11:33:54.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:15:0) after 1m8s
[11:35:02.887] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:15:0)
[11:35:02.918] Build status: STARTED
[11:35:02.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:16:0) after 4m44s
[11:39:46.944] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:16:0)
[11:39:47.029] Build status: STARTED
[11:39:47.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:17:0) after 2m39s
[11:42:26.046] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:17:0)
[11:42:26.096] Build status: STARTED
[11:42:26.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:18:0) after 2m23s
[11:44:49.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:18:0)
[11:44:49.153] Build status: STARTED
[11:44:49.153] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:19:0) after 6m47s
[11:51:36.252] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:19:0)
[11:51:36.273] Build status: STARTED
[11:51:36.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:20:0) after 7m45s
[11:59:21.286] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:20:0)
[11:59:21.314] Build status: STARTED
[11:59:21.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:21:0) after 3m14s
[12:02:35.363] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:21:0)
[12:02:35.392] Build status: STARTED
[12:02:35.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:22:0) after 4m1s
[12:06:36.475] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:22:0)
[12:06:36.507] Build status: STARTED
[12:06:36.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:23:0) after 1m4s
[12:07:40.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:23:0)
[12:07:40.666] Build status: STARTED
[12:07:40.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:24:0) after 1m55s
[12:09:35.683] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:24:0)
[12:09:35.705] Build status: STARTED
[12:09:35.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:25:0) after 2m12s
[12:11:48.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:25:0)
[12:11:48.143] Build status: STARTED
[12:11:48.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:26:0) after 6m20s
[12:18:08.293] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:26:0)
[12:18:08.314] Build status: STARTED
[12:18:08.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:27:0) after 6m13s
[12:24:21.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:27:0)
[12:24:21.382] Build status: STARTED
[12:24:21.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:28:0) after 5m33s
[12:29:54.554] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:28:0)
[12:29:54.574] Build status: STARTED
[12:29:54.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:29:0) after 2m10s
[12:32:04.602] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:29:0)
[12:32:04.622] Build status: STARTED
[12:32:04.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:30:0) after 2m23s
[12:34:27.730] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:30:0)
[12:34:27.767] Build status: STARTED
[12:34:27.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:31:0) after 9m6s
[12:43:33.953] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:31:0)
[12:43:33.984] Build status: STARTED
[12:43:33.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:32:0) after 6m15s
[12:49:49.001] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:32:0)
[12:49:49.021] Build status: STARTED
[12:49:49.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8875167295758217248:33:0) after 7m10s
[12:50:18.433] Received PubSub notification, asking Buildbucket for the build status
[12:50:18.452] Build:
{
"id": "8709737233720794785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-10T10:45:19.761006881Z",
"startTime": "2025-07-10T10:45:24.427926703Z",
"endTime": "2025-07-10T12:50:17.635231302Z",
"updateTime": "2025-07-10T12:50:17.635231302Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "cf3fb768db439825e3c8d327f6d9f46e02965668",
"ref": "refs/heads/main"
}
}
}
[12:50:18.452] Invocation finished in 2h5m0.017746646s with status SUCCEEDED