[05:24:39.100] New invocation is queued and will start shortly
[05:24:39.100] Triggered by user:rust-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[05:24:40.457] Starting the invocation (attempt 1)
[05:24:40.486] Popped buildset tag "buildset:commit/gitiles/rust.googlesource.com/rust/+/503dce33e2e2a5d2fe978b2723ab2a994cc27472"
[05:24:40.486] Reconstructed gitiles commit from tags
[05:24:40.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:24:40.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:24:40.486] Buildbucket request:
{
"requestId": "8863772251909317680",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9e3ed9216c2b86e8abebe680e2c68732ff6f3a42",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "fd396aa9ebb0453cbd2b9812f43da17709aff68f915fffa9c1c77b5f49d41c10/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863772251909317680",
"job": "fuchsia/toolchain.ci-rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9e3ed9216c2b86e8abebe680e2c68732ff6f3a42",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "fd396aa9ebb0453cbd2b9812f43da17709aff68f915fffa9c1c77b5f49d41c10/395",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://rust.googlesource.com/rust",
"git_revision": "503dce33e2e2a5d2fe978b2723ab2a994cc27472"
}
},
"tags": [
"buildset:commit/gitiles/rust.googlesource.com/rust/+/503dce33e2e2a5d2fe978b2723ab2a994cc27472",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-linux-x64-bootstrap",
"user_agent:recipe"
]
},
"id": "caf9f2fc-3b3f-4de0-83f2-69e9fa44ab25",
"title": "rust-linux-x64-bootstrap/0",
"url": "https://cr-buildbucket.appspot.com/build/8698352386745190577"
}
]
},
"rust_toolchain": {
"git_repository": "https://rust.googlesource.com/rust",
"git_revision": "503dce33e2e2a5d2fe978b2723ab2a994cc27472"
}
},
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "503dce33e2e2a5d2fe978b2723ab2a994cc27472",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863772251909317680"
},
{
"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"
}
}
[05:24:40.957] Scheduled build:
{
"id": "8698342189677449617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-13T05:24:40.599409674Z",
"updateTime": "2025-11-13T05:24:40.599409674Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "503dce33e2e2a5d2fe978b2723ab2a994cc27472",
"ref": "refs/heads/main"
}
}
}
[05:24:40.957] Task URL: https://cr-buildbucket.appspot.com/build/8698342189677449617
[05:24:40.957] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:2:0) after 6m56s
[05:24:41.054] Received PubSub notification, asking Buildbucket for the build status
[05:24:41.072] Build status: SCHEDULED
[05:24:44.932] Received PubSub notification, asking Buildbucket for the build status
[05:24:44.945] Build status: STARTED
[05:31:36.967] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:2:0)
[05:31:36.986] Build status: STARTED
[05:31:36.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:5:0) after 5m33s
[05:37:10.076] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:5:0)
[05:37:10.092] Build status: STARTED
[05:37:10.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:6:0) after 5m41s
[05:42:51.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:6:0)
[05:42:51.131] Build status: STARTED
[05:42:51.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:7:0) after 9m49s
[05:52:40.496] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:7:0)
[05:52:40.526] Build status: STARTED
[05:52:40.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:8:0) after 5m37s
[05:58:17.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:8:0)
[05:58:17.692] Build status: STARTED
[05:58:17.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:9:0) after 8m53s
[06:07:10.659] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:9:0)
[06:07:10.684] Build status: STARTED
[06:07:10.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:10:0) after 8m2s
[06:15:12.958] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:10:0)
[06:15:12.975] Build status: STARTED
[06:15:12.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:11:0) after 2m43s
[06:17:55.988] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:11:0)
[06:17:56.008] Build status: STARTED
[06:17:56.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:12:0) after 2m12s
[06:20:08.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:12:0)
[06:20:08.112] Build status: STARTED
[06:20:08.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:13:0) after 1m51s
[06:21:59.175] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:13:0)
[06:21:59.191] Build status: STARTED
[06:21:59.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:14:0) after 9m12s
[06:31:11.253] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:14:0)
[06:31:11.274] Build status: STARTED
[06:31:11.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:15:0) after 6m3s
[06:37:14.340] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:15:0)
[06:37:14.358] Build status: STARTED
[06:37:14.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:16:0) after 4m40s
[06:41:54.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:16:0)
[06:41:54.453] Build status: STARTED
[06:41:54.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:17:0) after 2m49s
[06:44:43.465] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:17:0)
[06:44:43.483] Build status: STARTED
[06:44:43.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:18:0) after 9m29s
[06:54:12.492] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:18:0)
[06:54:12.517] Build status: STARTED
[06:54:12.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:19:0) after 9m10s
[07:03:22.521] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:19:0)
[07:03:22.541] Build status: STARTED
[07:03:22.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:20:0) after 9m30s
[07:12:52.526] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:20:0)
[07:12:52.601] Build status: STARTED
[07:12:52.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_toolchain.core.x64-debug:8863772251909317680:21:0) after 9m53s
[07:21:42.650] Received PubSub notification, asking Buildbucket for the build status
[07:21:42.670] Build:
{
"id": "8698342189677449617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-13T05:24:40.599409674Z",
"startTime": "2025-11-13T05:24:44.550512363Z",
"endTime": "2025-11-13T07:21:42.300392246Z",
"updateTime": "2025-11-13T07:21:42.300392246Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "503dce33e2e2a5d2fe978b2723ab2a994cc27472",
"ref": "refs/heads/main"
}
}
}
[07:21:42.670] Invocation finished in 1h57m3.582559482s with status SUCCEEDED