[12:23:33.013] New invocation is queued and will start shortly
[12:23:33.013] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[12:23:34.122] Starting the invocation (attempt 1)
[12:23:34.145] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a41214f9bd7ce869d21898f31107f92c90a9112f"
[12:23:34.145] Reconstructed gitiles commit from tags
[12:23:34.145] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:23:34.145] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:23:34.146] Buildbucket request:
{
"requestId": "8866192015176159456",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a221a19d0c1368718cea749d6d9fbf3144b9aa76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "1edc4c2a18ab2a4a9b9b9e683dcf33561b6b5ed37fc677f83c17657e99eee79b/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866192015176159456",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a221a19d0c1368718cea749d6d9fbf3144b9aa76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "b0101e5060144f2e8b69ca3666987b77ad6494f846c5512c4081ac122c8dafcc/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "a41214f9bd7ce869d21898f31107f92c90a9112f"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a41214f9bd7ce869d21898f31107f92c90a9112f",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64",
"user_agent:recipe"
]
},
"id": "58d64f36-c89e-4510-a174-521849946c57",
"title": "rust-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8700766719242099521"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a221a19d0c1368718cea749d6d9fbf3144b9aa76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "1edc4c2a18ab2a4a9b9b9e683dcf33561b6b5ed37fc677f83c17657e99eee79b/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "a41214f9bd7ce869d21898f31107f92c90a9112f"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a41214f9bd7ce869d21898f31107f92c90a9112f",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64-bootstrap",
"user_agent:recipe"
]
},
"id": "ed976cf8-f168-471a-a14f-2622fb105103",
"title": "rust-linux-x64-bootstrap/0",
"url": "https://cr-buildbucket.appspot.com/build/8700766718701963089"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "a41214f9bd7ce869d21898f31107f92c90a9112f"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a41214f9bd7ce869d21898f31107f92c90a9112f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866192015176159456"
},
{
"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"
}
}
[12:23:34.524] Scheduled build:
{
"id": "8700761953264694593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-17T12:23:34.214979663Z",
"updateTime": "2025-10-17T12:23:34.214979663Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a41214f9bd7ce869d21898f31107f92c90a9112f",
"ref": "refs/heads/main"
}
}
}
[12:23:34.525] Task URL: https://cr-buildbucket.appspot.com/build/8700761953264694593
[12:23:34.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:2:0) after 6m39s
[12:23:35.549] Received PubSub notification, asking Buildbucket for the build status
[12:23:35.572] Build status: SCHEDULED
[12:23:39.937] Received PubSub notification, asking Buildbucket for the build status
[12:23:39.964] Build status: STARTED
[12:30:13.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:2:0)
[12:30:13.819] Build status: STARTED
[12:30:13.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:5:0) after 9m57s
[12:40:10.844] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:5:0)
[12:40:10.915] Build status: STARTED
[12:40:10.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:6:0) after 4m57s
[12:45:08.467] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:6:0)
[12:45:08.497] Build status: STARTED
[12:45:08.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:7:0) after 1m36s
[12:46:44.512] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:7:0)
[12:46:44.530] Build status: STARTED
[12:46:44.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:8:0) after 4m1s
[12:50:45.546] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:8:0)
[12:50:45.825] Build status: STARTED
[12:50:45.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:9:0) after 4m27s
[12:55:12.941] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:9:0)
[12:55:12.964] Build status: STARTED
[12:55:12.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:10:0) after 9m43s
[13:04:55.978] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:10:0)
[13:04:55.995] Build status: STARTED
[13:04:55.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:11:0) after 9m38s
[13:14:34.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:11:0)
[13:14:34.032] Build status: STARTED
[13:14:34.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:12:0) after 1m51s
[13:16:25.093] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:12:0)
[13:16:25.115] Build status: STARTED
[13:16:25.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:13:0) after 9m3s
[13:25:28.131] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:13:0)
[13:25:28.163] Build status: STARTED
[13:25:28.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:14:0) after 2m30s
[13:27:58.185] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:14:0)
[13:27:58.202] Build status: STARTED
[13:27:58.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:15:0) after 7m21s
[13:35:19.219] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:15:0)
[13:35:19.236] Build status: STARTED
[13:35:19.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:16:0) after 5m46s
[13:41:05.253] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:16:0)
[13:41:05.272] Build status: STARTED
[13:41:05.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:17:0) after 7m9s
[13:48:14.245] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:17:0)
[13:48:14.262] Build status: STARTED
[13:48:14.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:18:0) after 3m24s
[13:51:38.792] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:18:0)
[13:51:38.807] Build status: STARTED
[13:51:38.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:19:0) after 7m21s
[13:58:59.869] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:19:0)
[13:58:59.902] Build status: STARTED
[13:58:59.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:20:0) after 1m44s
[14:00:43.917] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:20:0)
[14:00:43.944] Build status: STARTED
[14:00:43.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:21:0) after 5m8s
[14:05:51.983] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:21:0)
[14:05:52.003] Build status: STARTED
[14:05:52.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:22:0) after 6m47s
[14:12:39.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:22:0)
[14:12:39.058] Build status: STARTED
[14:12:39.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:23:0) after 3m17s
[14:15:56.098] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:23:0)
[14:15:56.119] Build status: STARTED
[14:15:56.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8866192015176159456:24:0) after 8m20s
[14:19:44.169] Received PubSub notification, asking Buildbucket for the build status
[14:19:44.186] Build:
{
"id": "8700761953264694593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-17T12:23:34.214979663Z",
"startTime": "2025-10-17T12:23:39.710209958Z",
"endTime": "2025-10-17T14:19:43.729428444Z",
"updateTime": "2025-10-17T14:19:43.729428444Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a41214f9bd7ce869d21898f31107f92c90a9112f",
"ref": "refs/heads/main"
}
}
}
[14:19:44.186] Invocation finished in 1h56m11.177771463s with status SUCCEEDED